-- Logs begin at Tue 2024-11-26 14:58:27 CET, end at Tue 2024-11-26 15:04:20 CET. -- Nov 26 15:03:00 volumio.lufaan.nl ntpd[974]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 26 15:03:00 volumio.lufaan.nl sudo[3657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 15:02 Nov 26 15:03:00 volumio.lufaan.nl sudo[3657]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:00 volumio.lufaan.nl sudo[3657]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 26 15:03:01 volumio.lufaan.nl sudo[3638]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:01 volumio.lufaan.nl sudo[3611]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:01 volumio.lufaan.nl sudo[3602]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: Stopped Volumio Backend Module. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: Started Volumio Backend Module. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:03:01 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:03:02 volumio.lufaan.nl ntpd[974]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 26 15:03:02 volumio.lufaan.nl mpd[3634]: Nov 26 15:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 15:03:04 volumio.lufaan.nl systemd[1]: Started Music Player Daemon. Nov 26 15:03:04 volumio.lufaan.nl systemd[1]: Started MPD OLED Plugin. Nov 26 15:03:04 volumio.lufaan.nl systemd[3685]: mpd_oled_plugin.service: Failed to execute command: Exec format error Nov 26 15:03:04 volumio.lufaan.nl systemd[3685]: mpd_oled_plugin.service: Failed at step EXEC spawning /tmp/mpd_oled_plugin.sh: Exec format error Nov 26 15:03:04 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Main process exited, code=exited, status=203/EXEC Nov 26 15:03:04 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Failed with result 'exit-code'. Nov 26 15:03:04 volumio.lufaan.nl volumio[3670]: info: ------------------------------------------- Nov 26 15:03:04 volumio.lufaan.nl volumio[3670]: info: ----- Volumio3 ---- Nov 26 15:03:04 volumio.lufaan.nl volumio[3670]: info: ------------------------------------------- Nov 26 15:03:04 volumio.lufaan.nl volumio[3670]: info: ----- System startup ---- Nov 26 15:03:04 volumio.lufaan.nl volumio[3670]: info: ------------------------------------------- Nov 26 15:03:05 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:03:05] [connect] Successful connection Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: MYVOLUMIO Environment detected Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Plugin folders cleanup Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning into folder /volumio/app/plugins/ Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category audio_interface Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category miscellanea Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category music_service Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category plugins.json Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category system_controller Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category user_interface Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning into folder /data/plugins/ Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category music_service Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Scanning category system_hardware Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Plugin folders cleanup completed Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: ------------------------------------------- Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: ----- Core plugins startup ---- Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: ------------------------------------------- Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Loading plugins from folder /volumio/app/plugins/ Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Adding plugin upnp to MyMusic Plugins Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Loading plugins from folder /data/plugins/ Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Loading plugin "system"... Nov 26 15:03:06 volumio.lufaan.nl volumio[3670]: info: Loading plugin "appearance"... Nov 26 15:03:07 volumio.lufaan.nl volumio[3670]: info: Loading plugin "network"... Nov 26 15:03:07 volumio.lufaan.nl volumio[3670]: info: Refreshing Cached IP Addresses Nov 26 15:03:07 volumio.lufaan.nl sudo[3702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 15:03:07 volumio.lufaan.nl sudo[3702]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:07 volumio.lufaan.nl sudo[3702]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:07 volumio.lufaan.nl volumio[3670]: info: Loading plugin "services"... Nov 26 15:03:07 volumio.lufaan.nl sudo[3704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 15:03:07 volumio.lufaan.nl sudo[3704]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:07 volumio.lufaan.nl volumio[3670]: info: Loading plugin "alsa_controller"... Nov 26 15:03:07 volumio.lufaan.nl sudo[3707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 26 15:03:07 volumio.lufaan.nl sudo[3707]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:07 volumio.lufaan.nl sudo[3704]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:07 volumio.lufaan.nl sudo[3707]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:07 volumio.lufaan.nl volumio[3670]: warn: Unable to locate the audio output device SMSL USB AUDIO. Please configure a valid output device. Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Loading plugin "wizard"... Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Loading plugin "networkfs"... Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Starting Udev Watcher for removable devices Nov 26 15:03:08 volumio.lufaan.nl sudo[3717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.178.218:/volume1/my-music /mnt/NAS/Synology Nov 26 15:03:08 volumio.lufaan.nl sudo[3717]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Ignoring mount for partition: boot Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Ignoring mount for partition: volumio Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Ignoring mount for partition: volumio_data Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Loading plugin "volumio_command_line_client"... Nov 26 15:03:08 volumio.lufaan.nl sudo[3717]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Loading plugin "upnp"... Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: [1732629788153] Starting Upmpd Daemon Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Loading plugin "my_music"... Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Loading plugin "mpd"... Nov 26 15:03:08 volumio.lufaan.nl volumio[3670]: info: Loading plugin "upnp_browser"... Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Loading plugin "alarm-clock"... Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Loading plugin "airplay_emulation"... Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Starting Shairport Sync Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Loading plugin "last_100"... Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Loading plugin "webradio"... Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Loading plugin "i2s_dacs"... Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: I2S DAC not set, start Auto-detection Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Loading plugin "volumiodiscovery"... Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:09 volumio.lufaan.nl node[3670]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: *** WARNING *** For more information see Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: *** WARNING *** For more information see Nov 26 15:03:09 volumio.lufaan.nl node[3670]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:09 volumio.lufaan.nl node[3670]: *** WARNING *** For more information see Nov 26 15:03:09 volumio.lufaan.nl node[3670]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:09 volumio.lufaan.nl node[3670]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:09 volumio.lufaan.nl node[3670]: *** WARNING *** For more information see Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Discovery: Started advertising with name: volumio.lufaan.nl Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:09 volumio.lufaan.nl volumio[3670]: info: Loading plugin "calmradio"... Nov 26 15:03:10 volumio.lufaan.nl volumio[3670]: info: Loading plugin "squeezelite_mc"... Nov 26 15:03:12 volumio.lufaan.nl volumio[3670]: info: Loading plugin "ytmusic"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "outputs"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "albumart"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Plugin example_plugin is not enabled Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "inputs"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "updater_comm"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Plugin mpdemulation is not enabled Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "rest_api"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "websocket"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Starting Socket.io Server version 2.3.0 Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "80s80s"... Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: Forking 3 albumart workers Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Applying required configuration parameters for plugin 80s80s Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: [1732629794973] [80s80s] API delay: 30 Nov 26 15:03:14 volumio.lufaan.nl volumio[3670]: info: Loading plugin "motherearthradio"... Nov 26 15:03:15 volumio.lufaan.nl volumio[3670]: info: Applying required configuration parameters for plugin motherearthradio Nov 26 15:03:15 volumio.lufaan.nl volumio[3670]: info: [1732629795481] [MotherEarth] API delay: 5 Nov 26 15:03:15 volumio.lufaan.nl volumio[3670]: info: Loading plugin "radio_paradise"... Nov 26 15:03:15 volumio.lufaan.nl volumio[3670]: info: Applying required configuration parameters for plugin radio_paradise Nov 26 15:03:15 volumio.lufaan.nl volumio[3670]: info: [1732629795979] [RadioParadise] API delay: 5 Nov 26 15:03:15 volumio.lufaan.nl volumio[3670]: info: Loading plugin "mpd_oled"... Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: Starting albumart workers Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: Starting albumart workers Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: Starting albumart workers Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: Applying required configuration parameters for plugin mpd_oled Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: Loading i18n strings for locale nl Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: Updating browse sources language Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::initPlayerControls Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: Express server listening on port 3000 Nov 26 15:03:16 volumio.lufaan.nl volumio[3670]: [Metrics] WebUI: 12s 940.90ms Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::resetVolumioState Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::getcurrentVolume Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::pushState Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Completed loading Core Plugins Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Preparing to generate the ALSA configuration file Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Cannot mount NAS Synology at system boot, trial number 1 ,retrying in 5 seconds Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: wlan0 Interface doesn't support scanning. Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Cannot use regular scanning, forcing with ap-force Nov 26 15:03:17 volumio.lufaan.nl sudo[3778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Nov 26 15:03:17 volumio.lufaan.nl sudo[3778]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:17 volumio.lufaan.nl sudo[3778]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: command failed: No such device (-19) Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: command failed: No such device (-19) Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Reading ALSA contributions from plugins. Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Reloading queue from file Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::setRepeat null single undefined Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::pushState Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::setRandom null Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::pushState Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Asound.conf file unchanged, so no further update is needed Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Output device has changed, restarting MPD Nov 26 15:03:17 volumio.lufaan.nl sudo[3791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:03:17 volumio.lufaan.nl sudo[3791]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Output device has changed, restarting Shairport Sync Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:17 volumio.lufaan.nl sudo[3791]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:17 volumio.lufaan.nl sudo[3793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:03:17 volumio.lufaan.nl sudo[3793]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:17 volumio.lufaan.nl systemd[1]: Stopping Music Player Daemon... Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: ___________ START PLUGINS ___________ Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: ControllerMpd::onStart: Initializing MPD Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Creating MPD Configuration file Nov 26 15:03:17 volumio.lufaan.nl sudo[3800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:03:17 volumio.lufaan.nl sudo[3800]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: [1732629797835] CoreMusicLibrary::Adding element Media Servers Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:17 volumio.lufaan.nl sudo[3800]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:17 volumio.lufaan.nl sudo[3802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:03:17 volumio.lufaan.nl sudo[3802]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:17 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [1732629798036] CoreMusicLibrary::Adding element Last_100 Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [1732629798042] CoreMusicLibrary::Adding element Webradio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:18 volumio.lufaan.nl systemd[1]: mpd.service: Succeeded. Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: Initializing BBC Radios Nov 26 15:03:18 volumio.lufaan.nl systemd[1]: Stopped Music Player Daemon. Nov 26 15:03:18 volumio.lufaan.nl systemd[1]: Starting Music Player Daemon... Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: Adding Calm Radio to Browse Sources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [1732629798196] CoreMusicLibrary::Adding element Calm Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Calm Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [squeezelite_mc] Starting proxy server... Nov 26 15:03:18 volumio.lufaan.nl sudo[3811]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 15:03:18 volumio.lufaan.nl sudo[3811]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [1732629798256] CoreMusicLibrary::Adding element YouTube Music Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Calm Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source YouTube Music Nov 26 15:03:18 volumio.lufaan.nl sudo[3811]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [1732629798276] CoreMusicLibrary::Adding element 80s80s Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Calm Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source YouTube Music Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source 80s80s Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [1732629798291] CoreMusicLibrary::Adding element Mother Earth Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Calm Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source YouTube Music Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source 80s80s Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Mother Earth Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [1732629798303] CoreMusicLibrary::Adding element Radio Paradise Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Calm Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source YouTube Music Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source 80s80s Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Mother Earth Radio Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Cannot find translation for source Radio Paradise Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: error: [MPD_OLED Plugin] Failed to create mpdoledfifo: Error: Command failed: /usr/bin/mkfifo -m 646 /tmp/mpdoledfifo Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 26 15:03:18 volumio.lufaan.nl sudo[3827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Nov 26 15:03:18 volumio.lufaan.nl sudo[3827]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: Volumio Calling Home Nov 26 15:03:18 volumio.lufaan.nl sudo[3827]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:18 volumio.lufaan.nl sudo[3829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Nov 26 15:03:18 volumio.lufaan.nl sudo[3829]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [squeezelite_mc] Proxy server started on port 36897 Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: Preparing to generate the ALSA configuration file Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreStateMachine::pushState Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [squeezelite_mc] Server discovery started Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [squeezelite_mc] Player finder started Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-o squeezelite -C 1 -n \"volumio-sq\" -D 3:dop -f /tmp/squeezelite.log","card":"5","mixerType":"None","mixer":null} Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: Error: send ENETUNREACH 255.255.255.255:3483 Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: at doSend (dgram.js:714:16) Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: at afterDns (dgram.js:660:5) Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: errno: -101, Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: code: 'ENETUNREACH', Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: syscall: 'send', Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: address: '255.255.255.255', Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: port: 3483 Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: } Nov 26 15:03:18 volumio.lufaan.nl volumio[3670]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:03:19 volumio.lufaan.nl sudo[3837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:03:19 volumio.lufaan.nl sudo[3837]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:19 volumio.lufaan.nl sudo[3837]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:19 volumio.lufaan.nl sudo[3848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 15:02 Nov 26 15:03:19 volumio.lufaan.nl sudo[3848]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:20 volumio.lufaan.nl sudo[3848]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 26 15:03:20 volumio.lufaan.nl sudo[3802]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:20 volumio.lufaan.nl sudo[3829]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:20 volumio.lufaan.nl sudo[3793]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: volumio.service: Scheduled restart job, restart counter is at 14. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: Stopped Volumio Backend Module. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: Started Volumio Backend Module. Nov 26 15:03:20 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:03:20 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:03:20] [info] asio async_connect error: system:111 (Connection refused) Nov 26 15:03:20 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:03:20] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 15:03:20 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:03:20] [error] handle_connect error: Underlying Transport Error Nov 26 15:03:22 volumio.lufaan.nl mpd[3823]: Nov 26 15:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 15:03:23 volumio.lufaan.nl systemd[1]: Started Music Player Daemon. Nov 26 15:03:23 volumio.lufaan.nl systemd[1]: Started MPD OLED Plugin. Nov 26 15:03:23 volumio.lufaan.nl systemd[3884]: mpd_oled_plugin.service: Failed to execute command: Exec format error Nov 26 15:03:23 volumio.lufaan.nl systemd[3884]: mpd_oled_plugin.service: Failed at step EXEC spawning /tmp/mpd_oled_plugin.sh: Exec format error Nov 26 15:03:23 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Main process exited, code=exited, status=203/EXEC Nov 26 15:03:23 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Failed with result 'exit-code'. Nov 26 15:03:23 volumio.lufaan.nl volumio[3862]: info: ------------------------------------------- Nov 26 15:03:23 volumio.lufaan.nl volumio[3862]: info: ----- Volumio3 ---- Nov 26 15:03:23 volumio.lufaan.nl volumio[3862]: info: ------------------------------------------- Nov 26 15:03:23 volumio.lufaan.nl volumio[3862]: info: ----- System startup ---- Nov 26 15:03:23 volumio.lufaan.nl volumio[3862]: info: ------------------------------------------- Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: MYVOLUMIO Environment detected Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Plugin folders cleanup Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning into folder /volumio/app/plugins/ Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category audio_interface Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category miscellanea Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category music_service Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category plugins.json Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category system_controller Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category user_interface Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning into folder /data/plugins/ Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category music_service Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Scanning category system_hardware Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Plugin folders cleanup completed Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: ------------------------------------------- Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: ----- Core plugins startup ---- Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: ------------------------------------------- Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Loading plugins from folder /volumio/app/plugins/ Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Adding plugin upnp to MyMusic Plugins Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Loading plugins from folder /data/plugins/ Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Loading plugin "system"... Nov 26 15:03:25 volumio.lufaan.nl volumio[3862]: info: Loading plugin "appearance"... Nov 26 15:03:26 volumio.lufaan.nl volumio[3862]: info: Loading plugin "network"... Nov 26 15:03:26 volumio.lufaan.nl volumio[3862]: info: Refreshing Cached IP Addresses Nov 26 15:03:26 volumio.lufaan.nl volumio[3862]: info: Loading plugin "services"... Nov 26 15:03:26 volumio.lufaan.nl sudo[3892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 15:03:26 volumio.lufaan.nl sudo[3894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 15:03:26 volumio.lufaan.nl sudo[3894]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:26 volumio.lufaan.nl volumio[3862]: info: Loading plugin "alsa_controller"... Nov 26 15:03:26 volumio.lufaan.nl sudo[3892]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:26 volumio.lufaan.nl sudo[3896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 26 15:03:26 volumio.lufaan.nl sudo[3892]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:26 volumio.lufaan.nl sudo[3896]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:26 volumio.lufaan.nl sudo[3894]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:26 volumio.lufaan.nl sudo[3896]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: warn: Unable to locate the audio output device SMSL USB AUDIO. Please configure a valid output device. Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Loading plugin "wizard"... Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Loading plugin "networkfs"... Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Starting Udev Watcher for removable devices Nov 26 15:03:27 volumio.lufaan.nl sudo[3907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.178.218:/volume1/my-music /mnt/NAS/Synology Nov 26 15:03:27 volumio.lufaan.nl sudo[3907]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Ignoring mount for partition: boot Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Ignoring mount for partition: volumio Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Ignoring mount for partition: volumio_data Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Loading plugin "volumio_command_line_client"... Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Loading plugin "upnp"... Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: [1732629807215] Starting Upmpd Daemon Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:27 volumio.lufaan.nl sudo[3907]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Loading plugin "my_music"... Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Loading plugin "mpd"... Nov 26 15:03:27 volumio.lufaan.nl volumio[3862]: info: Loading plugin "upnp_browser"... Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Loading plugin "alarm-clock"... Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Loading plugin "airplay_emulation"... Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Starting Shairport Sync Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Loading plugin "last_100"... Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Loading plugin "webradio"... Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Loading plugin "i2s_dacs"... Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: I2S DAC not set, start Auto-detection Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Loading plugin "volumiodiscovery"... Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:28 volumio.lufaan.nl node[3862]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: *** WARNING *** For more information see Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: *** WARNING *** For more information see Nov 26 15:03:28 volumio.lufaan.nl node[3862]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:28 volumio.lufaan.nl node[3862]: *** WARNING *** For more information see Nov 26 15:03:28 volumio.lufaan.nl node[3862]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:28 volumio.lufaan.nl node[3862]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:28 volumio.lufaan.nl node[3862]: *** WARNING *** For more information see Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Discovery: Started advertising with name: volumio.lufaan.nl Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:28 volumio.lufaan.nl volumio[3862]: info: Loading plugin "calmradio"... Nov 26 15:03:30 volumio.lufaan.nl volumio[3862]: info: Loading plugin "squeezelite_mc"... Nov 26 15:03:30 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:03:30] [connect] Successful connection Nov 26 15:03:31 volumio.lufaan.nl volumio[3862]: info: Loading plugin "ytmusic"... Nov 26 15:03:33 volumio.lufaan.nl volumio[3862]: info: Loading plugin "outputs"... Nov 26 15:03:33 volumio.lufaan.nl volumio[3862]: info: Loading plugin "albumart"... Nov 26 15:03:33 volumio.lufaan.nl volumio[3862]: info: Plugin example_plugin is not enabled Nov 26 15:03:33 volumio.lufaan.nl volumio[3862]: info: Loading plugin "inputs"... Nov 26 15:03:33 volumio.lufaan.nl volumio[3862]: info: Loading plugin "updater_comm"... Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Plugin mpdemulation is not enabled Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Loading plugin "rest_api"... Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Loading plugin "websocket"... Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Starting Socket.io Server version 2.3.0 Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Loading plugin "80s80s"... Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: Forking 3 albumart workers Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Applying required configuration parameters for plugin 80s80s Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: [1732629814543] [80s80s] API delay: 30 Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Loading plugin "motherearthradio"... Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Applying required configuration parameters for plugin motherearthradio Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: [1732629814961] [MotherEarth] API delay: 5 Nov 26 15:03:34 volumio.lufaan.nl volumio[3862]: info: Loading plugin "radio_paradise"... Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: info: Applying required configuration parameters for plugin radio_paradise Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: info: [1732629815383] [RadioParadise] API delay: 5 Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: info: Loading plugin "mpd_oled"... Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: info: Applying required configuration parameters for plugin mpd_oled Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: info: Loading i18n strings for locale nl Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: Updating browse sources language Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: Starting albumart workers Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: Starting albumart workers Nov 26 15:03:35 volumio.lufaan.nl volumio[3862]: Starting albumart workers Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::initPlayerControls Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: Express server listening on port 3000 Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: [Metrics] WebUI: 13s 254.88ms Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::resetVolumioState Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::getcurrentVolume Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::pushState Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Completed loading Core Plugins Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Preparing to generate the ALSA configuration file Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Cannot mount NAS Synology at system boot, trial number 1 ,retrying in 5 seconds Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: wlan0 Interface doesn't support scanning. Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Cannot use regular scanning, forcing with ap-force Nov 26 15:03:36 volumio.lufaan.nl sudo[3993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Nov 26 15:03:36 volumio.lufaan.nl sudo[3993]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:36 volumio.lufaan.nl sudo[3993]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: command failed: No such device (-19) Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: command failed: No such device (-19) Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Reading ALSA contributions from plugins. Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Reloading queue from file Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::setRepeat null single undefined Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::pushState Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::setRandom null Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::pushState Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Asound.conf file unchanged, so no further update is needed Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Output device has changed, restarting MPD Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: Output device has changed, restarting Shairport Sync Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:36 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:37 volumio.lufaan.nl sudo[4003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:03:37 volumio.lufaan.nl sudo[4003]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:37 volumio.lufaan.nl sudo[4003]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:37 volumio.lufaan.nl sudo[4012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:03:37 volumio.lufaan.nl sudo[4012]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:37 volumio.lufaan.nl systemd[1]: Stopping Music Player Daemon... Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: ___________ START PLUGINS ___________ Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: ControllerMpd::onStart: Initializing MPD Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Creating MPD Configuration file Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:37 volumio.lufaan.nl sudo[4035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:03:37 volumio.lufaan.nl sudo[4035]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl sudo[4035]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817242] CoreMusicLibrary::Adding element Media Servers Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl sudo[4038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:03:37 volumio.lufaan.nl sudo[4038]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817439] CoreMusicLibrary::Adding element Last_100 Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817445] CoreMusicLibrary::Adding element Webradio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Initializing BBC Radios Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Adding Calm Radio to Browse Sources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817581] CoreMusicLibrary::Adding element Calm Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Calm Radio Nov 26 15:03:37 volumio.lufaan.nl systemd[1]: mpd.service: Succeeded. Nov 26 15:03:37 volumio.lufaan.nl systemd[1]: Stopped Music Player Daemon. Nov 26 15:03:37 volumio.lufaan.nl systemd[1]: Starting Music Player Daemon... Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [squeezelite_mc] Starting proxy server... Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817640] CoreMusicLibrary::Adding element YouTube Music Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Calm Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source YouTube Music Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817654] CoreMusicLibrary::Adding element 80s80s Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Calm Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source YouTube Music Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source 80s80s Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817665] CoreMusicLibrary::Adding element Mother Earth Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Calm Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source YouTube Music Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source 80s80s Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Mother Earth Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [1732629817675] CoreMusicLibrary::Adding element Radio Paradise Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Calm Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source YouTube Music Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source 80s80s Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Mother Earth Radio Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: Cannot find translation for source Radio Paradise Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: error: [MPD_OLED Plugin] Failed to create mpdoledfifo: Error: Command failed: /usr/bin/mkfifo -m 646 /tmp/mpdoledfifo Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 26 15:03:37 volumio.lufaan.nl sudo[4058]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 15:03:37 volumio.lufaan.nl sudo[4058]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:37 volumio.lufaan.nl sudo[4063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Volumio Calling Home Nov 26 15:03:37 volumio.lufaan.nl sudo[4063]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:37 volumio.lufaan.nl sudo[4058]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:37 volumio.lufaan.nl sudo[4063]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:37 volumio.lufaan.nl sudo[4066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Nov 26 15:03:37 volumio.lufaan.nl sudo[4066]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: [squeezelite_mc] Proxy server started on port 33527 Nov 26 15:03:37 volumio.lufaan.nl volumio[3862]: info: Preparing to generate the ALSA configuration file Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: CoreStateMachine::pushState Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: [squeezelite_mc] Server discovery started Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: [squeezelite_mc] Player finder started Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-o squeezelite -C 1 -n \"volumio-sq\" -D 3:dop -f /tmp/squeezelite.log","card":"5","mixerType":"None","mixer":null} Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: Error: send ENETUNREACH 255.255.255.255:3483 Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: at doSend (dgram.js:714:16) Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: at afterDns (dgram.js:660:5) Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: errno: -101, Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: code: 'ENETUNREACH', Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: syscall: 'send', Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: address: '255.255.255.255', Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: port: 3483 Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: } Nov 26 15:03:38 volumio.lufaan.nl volumio[3862]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:03:38 volumio.lufaan.nl sudo[4075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:03:38 volumio.lufaan.nl sudo[4075]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:38 volumio.lufaan.nl sudo[4075]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:39 volumio.lufaan.nl sudo[4086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 15:02 Nov 26 15:03:39 volumio.lufaan.nl sudo[4086]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:39 volumio.lufaan.nl sudo[4086]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 26 15:03:40 volumio.lufaan.nl sudo[4012]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:40 volumio.lufaan.nl sudo[4066]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:40 volumio.lufaan.nl sudo[4038]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: volumio.service: Scheduled restart job, restart counter is at 15. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: Stopped Volumio Backend Module. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: Started Volumio Backend Module. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:03:40 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:03:41 volumio.lufaan.nl mpd[4069]: Nov 26 15:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 15:03:42 volumio.lufaan.nl systemd[1]: Started Music Player Daemon. Nov 26 15:03:42 volumio.lufaan.nl systemd[1]: Started MPD OLED Plugin. Nov 26 15:03:42 volumio.lufaan.nl systemd[4114]: mpd_oled_plugin.service: Failed to execute command: Exec format error Nov 26 15:03:42 volumio.lufaan.nl systemd[4114]: mpd_oled_plugin.service: Failed at step EXEC spawning /tmp/mpd_oled_plugin.sh: Exec format error Nov 26 15:03:42 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Main process exited, code=exited, status=203/EXEC Nov 26 15:03:42 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Failed with result 'exit-code'. Nov 26 15:03:44 volumio.lufaan.nl volumio[4099]: info: ------------------------------------------- Nov 26 15:03:44 volumio.lufaan.nl volumio[4099]: info: ----- Volumio3 ---- Nov 26 15:03:44 volumio.lufaan.nl volumio[4099]: info: ------------------------------------------- Nov 26 15:03:44 volumio.lufaan.nl volumio[4099]: info: ----- System startup ---- Nov 26 15:03:44 volumio.lufaan.nl volumio[4099]: info: ------------------------------------------- Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: MYVOLUMIO Environment detected Nov 26 15:03:45 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:03:45] [connect] Successful connection Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Plugin folders cleanup Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning into folder /volumio/app/plugins/ Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category audio_interface Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category miscellanea Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category music_service Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category plugins.json Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category system_controller Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category user_interface Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning into folder /data/plugins/ Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category music_service Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Scanning category system_hardware Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Plugin folders cleanup completed Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: ------------------------------------------- Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: ----- Core plugins startup ---- Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: ------------------------------------------- Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Loading plugins from folder /volumio/app/plugins/ Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Adding plugin upnp to MyMusic Plugins Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Loading plugins from folder /data/plugins/ Nov 26 15:03:45 volumio.lufaan.nl volumio[4099]: info: Loading plugin "system"... Nov 26 15:03:46 volumio.lufaan.nl volumio[4099]: info: Loading plugin "appearance"... Nov 26 15:03:47 volumio.lufaan.nl volumio[4099]: info: Loading plugin "network"... Nov 26 15:03:47 volumio.lufaan.nl volumio[4099]: info: Refreshing Cached IP Addresses Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "services"... Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "alsa_controller"... Nov 26 15:03:48 volumio.lufaan.nl sudo[4134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 26 15:03:48 volumio.lufaan.nl sudo[4130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 15:03:48 volumio.lufaan.nl sudo[4132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 15:03:48 volumio.lufaan.nl sudo[4132]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:48 volumio.lufaan.nl sudo[4134]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:48 volumio.lufaan.nl sudo[4130]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:48 volumio.lufaan.nl sudo[4130]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:48 volumio.lufaan.nl sudo[4134]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:48 volumio.lufaan.nl sudo[4132]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: warn: Unable to locate the audio output device SMSL USB AUDIO. Please configure a valid output device. Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "wizard"... Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "networkfs"... Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Starting Udev Watcher for removable devices Nov 26 15:03:48 volumio.lufaan.nl sudo[4146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.178.218:/volume1/my-music /mnt/NAS/Synology Nov 26 15:03:48 volumio.lufaan.nl sudo[4146]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Ignoring mount for partition: boot Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Ignoring mount for partition: volumio Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Ignoring mount for partition: volumio_data Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "volumio_command_line_client"... Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "upnp"... Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: [1732629828322] Starting Upmpd Daemon Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "my_music"... Nov 26 15:03:48 volumio.lufaan.nl sudo[4146]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "mpd"... Nov 26 15:03:48 volumio.lufaan.nl volumio[4099]: info: Loading plugin "upnp_browser"... Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: Loading plugin "alarm-clock"... Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: Loading plugin "airplay_emulation"... Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: Starting Shairport Sync Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: Loading plugin "last_100"... Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: Loading plugin "webradio"... Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: Loading plugin "i2s_dacs"... Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: I2S DAC not set, start Auto-detection Nov 26 15:03:49 volumio.lufaan.nl volumio[4099]: info: Loading plugin "volumiodiscovery"... Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: *** WARNING *** For more information see Nov 26 15:03:50 volumio.lufaan.nl node[4099]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: *** WARNING *** For more information see Nov 26 15:03:50 volumio.lufaan.nl node[4099]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:50 volumio.lufaan.nl node[4099]: *** WARNING *** For more information see Nov 26 15:03:50 volumio.lufaan.nl node[4099]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:03:50 volumio.lufaan.nl node[4099]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:03:50 volumio.lufaan.nl node[4099]: *** WARNING *** For more information see Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: info: Discovery: Started advertising with name: volumio.lufaan.nl Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:03:50 volumio.lufaan.nl volumio[4099]: info: Loading plugin "calmradio"... Nov 26 15:03:51 volumio.lufaan.nl volumio[4099]: info: Loading plugin "squeezelite_mc"... Nov 26 15:03:52 volumio.lufaan.nl volumio[4099]: info: Loading plugin "ytmusic"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Loading plugin "outputs"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Loading plugin "albumart"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Plugin example_plugin is not enabled Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Loading plugin "inputs"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Loading plugin "updater_comm"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Plugin mpdemulation is not enabled Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Loading plugin "rest_api"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Loading plugin "websocket"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Starting Socket.io Server version 2.3.0 Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: info: Loading plugin "80s80s"... Nov 26 15:03:54 volumio.lufaan.nl volumio[4099]: Forking 3 albumart workers Nov 26 15:03:55 volumio.lufaan.nl volumio[4099]: info: Applying required configuration parameters for plugin 80s80s Nov 26 15:03:55 volumio.lufaan.nl volumio[4099]: info: [1732629835290] [80s80s] API delay: 30 Nov 26 15:03:55 volumio.lufaan.nl volumio[4099]: info: Loading plugin "motherearthradio"... Nov 26 15:03:55 volumio.lufaan.nl volumio[4099]: info: Applying required configuration parameters for plugin motherearthradio Nov 26 15:03:55 volumio.lufaan.nl volumio[4099]: info: [1732629835798] [MotherEarth] API delay: 5 Nov 26 15:03:55 volumio.lufaan.nl volumio[4099]: info: Loading plugin "radio_paradise"... Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: info: Applying required configuration parameters for plugin radio_paradise Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: info: [1732629836303] [RadioParadise] API delay: 5 Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: info: Loading plugin "mpd_oled"... Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: Starting albumart workers Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: Starting albumart workers Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: Starting albumart workers Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: info: Applying required configuration parameters for plugin mpd_oled Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: info: Loading i18n strings for locale nl Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: Updating browse sources language Nov 26 15:03:56 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::initPlayerControls Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: Express server listening on port 3000 Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: [Metrics] WebUI: 14s 20.39ms Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::resetVolumioState Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::getcurrentVolume Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::pushState Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Completed loading Core Plugins Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Preparing to generate the ALSA configuration file Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Cannot mount NAS Synology at system boot, trial number 1 ,retrying in 5 seconds Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: wlan0 Interface doesn't support scanning. Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Cannot use regular scanning, forcing with ap-force Nov 26 15:03:57 volumio.lufaan.nl sudo[4212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Nov 26 15:03:57 volumio.lufaan.nl sudo[4212]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:57 volumio.lufaan.nl sudo[4212]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: command failed: No such device (-19) Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: command failed: No such device (-19) Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Reading ALSA contributions from plugins. Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Reloading queue from file Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::setRepeat null single undefined Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::pushState Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::setRandom null Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::pushState Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Asound.conf file unchanged, so no further update is needed Nov 26 15:03:57 volumio.lufaan.nl volumio[4099]: info: Output device has changed, restarting MPD Nov 26 15:03:58 volumio.lufaan.nl sudo[4221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:03:58 volumio.lufaan.nl sudo[4221]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Output device has changed, restarting Shairport Sync Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl sudo[4221]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:58 volumio.lufaan.nl sudo[4223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:03:58 volumio.lufaan.nl sudo[4223]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:58 volumio.lufaan.nl systemd[1]: Stopping Music Player Daemon... Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: ___________ START PLUGINS ___________ Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: ControllerMpd::onStart: Initializing MPD Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Creating MPD Configuration file Nov 26 15:03:58 volumio.lufaan.nl sudo[4230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl sudo[4230]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838185] CoreMusicLibrary::Adding element Media Servers Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl sudo[4230]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:58 volumio.lufaan.nl sudo[4232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:03:58 volumio.lufaan.nl sudo[4232]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838382] CoreMusicLibrary::Adding element Last_100 Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838389] CoreMusicLibrary::Adding element Webradio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Initializing BBC Radios Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Adding Calm Radio to Browse Sources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838518] CoreMusicLibrary::Adding element Calm Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Calm Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [squeezelite_mc] Starting proxy server... Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838581] CoreMusicLibrary::Adding element YouTube Music Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Calm Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source YouTube Music Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838604] CoreMusicLibrary::Adding element 80s80s Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Calm Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source YouTube Music Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source 80s80s Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838619] CoreMusicLibrary::Adding element Mother Earth Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Calm Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source YouTube Music Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source 80s80s Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Mother Earth Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [1732629838640] CoreMusicLibrary::Adding element Radio Paradise Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Calm Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source YouTube Music Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source 80s80s Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Mother Earth Radio Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: Cannot find translation for source Radio Paradise Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: error: [MPD_OLED Plugin] Failed to create mpdoledfifo: Error: Command failed: /usr/bin/mkfifo -m 646 /tmp/mpdoledfifo Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 26 15:03:58 volumio.lufaan.nl sudo[4254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Volumio Calling Home Nov 26 15:03:58 volumio.lufaan.nl sudo[4254]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:58 volumio.lufaan.nl sudo[4254]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:58 volumio.lufaan.nl sudo[4256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Nov 26 15:03:58 volumio.lufaan.nl sudo[4256]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:58 volumio.lufaan.nl systemd[1]: mpd.service: Succeeded. Nov 26 15:03:58 volumio.lufaan.nl systemd[1]: Stopped Music Player Daemon. Nov 26 15:03:58 volumio.lufaan.nl systemd[1]: Starting Music Player Daemon... Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: [squeezelite_mc] Proxy server started on port 40393 Nov 26 15:03:58 volumio.lufaan.nl volumio[4099]: info: Preparing to generate the ALSA configuration file Nov 26 15:03:58 volumio.lufaan.nl sudo[4261]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 15:03:58 volumio.lufaan.nl sudo[4261]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:59 volumio.lufaan.nl sudo[4261]: pam_unix(sudo:session): session closed for user root Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: CoreStateMachine::pushState Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: CorePlayQueue::getTrack 0 Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::volumioPushState Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: [squeezelite_mc] Server discovery started Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: [squeezelite_mc] Player finder started Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-o squeezelite -C 1 -n \"volumio-sq\" -D 3:dop -f /tmp/squeezelite.log","card":"5","mixerType":"None","mixer":null} Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: Error: send ENETUNREACH 255.255.255.255:3483 Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: at doSend (dgram.js:714:16) Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: at afterDns (dgram.js:660:5) Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: errno: -101, Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: code: 'ENETUNREACH', Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: syscall: 'send', Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: address: '255.255.255.255', Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: port: 3483 Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: } Nov 26 15:03:59 volumio.lufaan.nl volumio[4099]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:03:59 volumio.lufaan.nl sudo[4268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:03:59 volumio.lufaan.nl sudo[4268]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:03:59 volumio.lufaan.nl sudo[4268]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:00 volumio.lufaan.nl sudo[4279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 15:03 Nov 26 15:04:00 volumio.lufaan.nl sudo[4279]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:00 volumio.lufaan.nl sudo[4279]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 26 15:04:00 volumio.lufaan.nl sudo[4256]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:00 volumio.lufaan.nl sudo[4223]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:00 volumio.lufaan.nl sudo[4232]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: volumio.service: Scheduled restart job, restart counter is at 16. Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: Started dynamicswap service. Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: Stopped Volumio Backend Module. Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: Started Volumio Backend Module. Nov 26 15:04:00 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:04:00] [info] asio async_connect error: system:111 (Connection refused) Nov 26 15:04:00 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:04:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 15:04:00 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:04:00] [error] handle_connect error: Underlying Transport Error Nov 26 15:04:00 volumio.lufaan.nl systemd[1]: dynamicswap.service: Succeeded. Nov 26 15:04:02 volumio.lufaan.nl mpd[4265]: Nov 26 15:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 15:04:02 volumio.lufaan.nl ntpd[974]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 26 15:04:03 volumio.lufaan.nl systemd[1]: Started Music Player Daemon. Nov 26 15:04:03 volumio.lufaan.nl systemd[1]: Started MPD OLED Plugin. Nov 26 15:04:03 volumio.lufaan.nl systemd[4307]: mpd_oled_plugin.service: Failed to execute command: Exec format error Nov 26 15:04:03 volumio.lufaan.nl systemd[4307]: mpd_oled_plugin.service: Failed at step EXEC spawning /tmp/mpd_oled_plugin.sh: Exec format error Nov 26 15:04:03 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Main process exited, code=exited, status=203/EXEC Nov 26 15:04:03 volumio.lufaan.nl systemd[1]: mpd_oled_plugin.service: Failed with result 'exit-code'. Nov 26 15:04:04 volumio.lufaan.nl ntpd[974]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 26 15:04:04 volumio.lufaan.nl volumio[4293]: info: ------------------------------------------- Nov 26 15:04:04 volumio.lufaan.nl volumio[4293]: info: ----- Volumio3 ---- Nov 26 15:04:04 volumio.lufaan.nl volumio[4293]: info: ------------------------------------------- Nov 26 15:04:04 volumio.lufaan.nl volumio[4293]: info: ----- System startup ---- Nov 26 15:04:04 volumio.lufaan.nl volumio[4293]: info: ------------------------------------------- Nov 26 15:04:05 volumio.lufaan.nl volumio[4293]: info: MYVOLUMIO Environment detected Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Plugin folders cleanup Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning into folder /volumio/app/plugins/ Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category audio_interface Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category miscellanea Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category music_service Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category plugins.json Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category system_controller Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category user_interface Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning into folder /data/plugins/ Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category music_service Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Scanning category system_hardware Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Plugin folders cleanup completed Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: ------------------------------------------- Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: ----- Core plugins startup ---- Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: ------------------------------------------- Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Loading plugins from folder /volumio/app/plugins/ Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Adding plugin upnp to MyMusic Plugins Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Loading plugins from folder /data/plugins/ Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Loading plugin "system"... Nov 26 15:04:06 volumio.lufaan.nl volumio[4293]: info: Loading plugin "appearance"... Nov 26 15:04:07 volumio.lufaan.nl ntpd[974]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: info: Loading plugin "network"... Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: info: Refreshing Cached IP Addresses Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: info: Loading plugin "services"... Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: info: Loading plugin "alsa_controller"... Nov 26 15:04:07 volumio.lufaan.nl sudo[4323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 15:04:07 volumio.lufaan.nl sudo[4325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 15:04:07 volumio.lufaan.nl sudo[4327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 26 15:04:07 volumio.lufaan.nl sudo[4323]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:07 volumio.lufaan.nl sudo[4327]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:07 volumio.lufaan.nl sudo[4325]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:07 volumio.lufaan.nl sudo[4323]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:07 volumio.lufaan.nl sudo[4327]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:07 volumio.lufaan.nl sudo[4325]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: warn: Unable to locate the audio output device SMSL USB AUDIO. Please configure a valid output device. Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: info: Loading plugin "wizard"... Nov 26 15:04:07 volumio.lufaan.nl volumio[4293]: info: Loading plugin "networkfs"... Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Starting Udev Watcher for removable devices Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Ignoring mount for partition: boot Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Ignoring mount for partition: volumio Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Ignoring mount for partition: volumio_data Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:04:08 volumio.lufaan.nl sudo[4338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.178.218:/volume1/my-music /mnt/NAS/Synology Nov 26 15:04:08 volumio.lufaan.nl sudo[4338]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Loading plugin "volumio_command_line_client"... Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Loading plugin "upnp"... Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: [1732629848116] Starting Upmpd Daemon Nov 26 15:04:08 volumio.lufaan.nl sudo[4338]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Loading plugin "my_music"... Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Loading plugin "mpd"... Nov 26 15:04:08 volumio.lufaan.nl ntpd[974]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 26 15:04:08 volumio.lufaan.nl volumio[4293]: info: Loading plugin "upnp_browser"... Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Loading plugin "alarm-clock"... Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Loading plugin "airplay_emulation"... Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Starting Shairport Sync Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Loading plugin "last_100"... Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Loading plugin "webradio"... Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Loading plugin "i2s_dacs"... Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: I2S DAC not set, start Auto-detection Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Loading plugin "volumiodiscovery"... Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:04:09 volumio.lufaan.nl node[4293]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: *** WARNING *** For more information see Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: *** WARNING *** For more information see Nov 26 15:04:09 volumio.lufaan.nl node[4293]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:04:09 volumio.lufaan.nl node[4293]: *** WARNING *** For more information see Nov 26 15:04:09 volumio.lufaan.nl node[4293]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 15:04:09 volumio.lufaan.nl node[4293]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 15:04:09 volumio.lufaan.nl node[4293]: *** WARNING *** For more information see Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Discovery: Started advertising with name: volumio.lufaan.nl Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 15:04:09 volumio.lufaan.nl volumio[4293]: info: Loading plugin "calmradio"... Nov 26 15:04:10 volumio.lufaan.nl volumio-remote-updater[707]: [2024-11-26 15:04:10] [connect] Successful connection Nov 26 15:04:11 volumio.lufaan.nl volumio[4293]: info: Loading plugin "squeezelite_mc"... Nov 26 15:04:12 volumio.lufaan.nl volumio[4293]: info: Loading plugin "ytmusic"... Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Loading plugin "outputs"... Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Loading plugin "albumart"... Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Plugin example_plugin is not enabled Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Loading plugin "inputs"... Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Loading plugin "updater_comm"... Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Plugin mpdemulation is not enabled Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Loading plugin "rest_api"... Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Loading plugin "websocket"... Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Starting Socket.io Server version 2.3.0 Nov 26 15:04:14 volumio.lufaan.nl volumio[4293]: info: Loading plugin "80s80s"... Nov 26 15:04:15 volumio.lufaan.nl volumio[4293]: Forking 3 albumart workers Nov 26 15:04:15 volumio.lufaan.nl volumio[4293]: info: Applying required configuration parameters for plugin 80s80s Nov 26 15:04:15 volumio.lufaan.nl volumio[4293]: info: [1732629855419] [80s80s] API delay: 30 Nov 26 15:04:15 volumio.lufaan.nl volumio[4293]: info: Loading plugin "motherearthradio"... Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: carrier acquired Nov 26 15:04:15 volumio.lufaan.nl kernel: dwmac-sun8i 1c30000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: IAID 4b:cf:cc:c4 Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: soliciting an IPv6 router Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: soliciting a DHCP lease Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: offered 192.168.178.100 from 192.168.178.253 Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: NAK: wrong server-ID from 192.168.178.252 Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: message: wrong server-ID Nov 26 15:04:15 volumio.lufaan.nl volumio[4293]: info: Applying required configuration parameters for plugin motherearthradio Nov 26 15:04:15 volumio.lufaan.nl volumio[4293]: info: [1732629855872] [MotherEarth] API delay: 5 Nov 26 15:04:15 volumio.lufaan.nl volumio[4293]: info: Loading plugin "radio_paradise"... Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: soliciting a DHCP lease Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: offered 192.168.178.100 from 192.168.178.253 Nov 26 15:04:15 volumio.lufaan.nl dhcpcd[796]: eth0: probing address 192.168.178.100/24 Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: info: Applying required configuration parameters for plugin radio_paradise Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: info: [1732629856330] [RadioParadise] API delay: 5 Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: info: Loading plugin "mpd_oled"... Nov 26 15:04:16 volumio.lufaan.nl ifplugd(eth0)[967]: Link beat detected. Nov 26 15:04:16 volumio.lufaan.nl ifplugd(eth0)[967]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: info: Applying required configuration parameters for plugin mpd_oled Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: info: Loading i18n strings for locale nl Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: Updating browse sources language Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:16 volumio.lufaan.nl ifplugd(eth0)[967]: client: command failed: No such device (-19) Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: Starting albumart workers Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: Starting albumart workers Nov 26 15:04:16 volumio.lufaan.nl volumio[4293]: Starting albumart workers Nov 26 15:04:17 volumio.lufaan.nl ifplugd(eth0)[967]: client: sending commands to master dhcpcd process Nov 26 15:04:17 volumio.lufaan.nl dhcpcd[4404]: sending commands to master dhcpcd process Nov 26 15:04:17 volumio.lufaan.nl dhcpcd[796]: control command: /sbin/dhcpcd eth0 Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::initPlayerControls Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: Express server listening on port 3000 Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: [Metrics] WebUI: 13s 942.65ms Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::resetVolumioState Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::getcurrentVolume Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::pushState Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CorePlayQueue::getTrack 0 Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioPushState Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: Completed loading Core Plugins Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: Preparing to generate the ALSA configuration file Nov 26 15:04:17 volumio.lufaan.nl ifplugd(eth0)[967]: Program executed successfully. Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: Cannot mount NAS Synology at system boot, trial number 1 ,retrying in 5 seconds Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: wlan0 Interface doesn't support scanning. Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: Cannot use regular scanning, forcing with ap-force Nov 26 15:04:17 volumio.lufaan.nl sudo[4440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Nov 26 15:04:17 volumio.lufaan.nl sudo[4440]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:17 volumio.lufaan.nl sudo[4440]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: command failed: No such device (-19) Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: command failed: No such device (-19) Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Nov 26 15:04:17 volumio.lufaan.nl volumio[4293]: info: Reading ALSA contributions from plugins. Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Reloading queue from file Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::setRepeat null single undefined Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::pushState Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CorePlayQueue::getTrack 0 Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioPushState Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::setRandom null Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::pushState Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CorePlayQueue::getTrack 0 Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioPushState Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Asound.conf file unchanged, so no further update is needed Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Output device has changed, restarting MPD Nov 26 15:04:18 volumio.lufaan.nl sudo[4470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Output device has changed, restarting Shairport Sync Nov 26 15:04:18 volumio.lufaan.nl sudo[4470]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl sudo[4470]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:18 volumio.lufaan.nl sudo[4476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:04:18 volumio.lufaan.nl sudo[4476]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: ___________ START PLUGINS ___________ Nov 26 15:04:18 volumio.lufaan.nl systemd[1]: Stopping Music Player Daemon... Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: ControllerMpd::onStart: Initializing MPD Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Creating MPD Configuration file Nov 26 15:04:18 volumio.lufaan.nl sudo[4482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl sudo[4482]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858342] CoreMusicLibrary::Adding element Media Servers Nov 26 15:04:18 volumio.lufaan.nl sudo[4482]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl sudo[4484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 15:04:18 volumio.lufaan.nl sudo[4484]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858542] CoreMusicLibrary::Adding element Last_100 Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858548] CoreMusicLibrary::Adding element Webradio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Initializing BBC Radios Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Adding Calm Radio to Browse Sources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858677] CoreMusicLibrary::Adding element Calm Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Calm Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [squeezelite_mc] Starting proxy server... Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858750] CoreMusicLibrary::Adding element YouTube Music Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Calm Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source YouTube Music Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858767] CoreMusicLibrary::Adding element 80s80s Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Calm Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source YouTube Music Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source 80s80s Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858779] CoreMusicLibrary::Adding element Mother Earth Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Calm Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source YouTube Music Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source 80s80s Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Mother Earth Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: [1732629858791] CoreMusicLibrary::Adding element Radio Paradise Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Calm Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source YouTube Music Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source 80s80s Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Mother Earth Radio Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: Cannot find translation for source Radio Paradise Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: error: [MPD_OLED Plugin] Failed to create mpdoledfifo: Error: Command failed: /usr/bin/mkfifo -m 646 /tmp/mpdoledfifo Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 26 15:04:18 volumio.lufaan.nl volumio[4293]: info: Volumio Calling Home Nov 26 15:04:18 volumio.lufaan.nl sudo[4506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Nov 26 15:04:18 volumio.lufaan.nl sudo[4506]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:18 volumio.lufaan.nl sudo[4506]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:18 volumio.lufaan.nl sudo[4508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Nov 26 15:04:18 volumio.lufaan.nl sudo[4508]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: [squeezelite_mc] Proxy server started on port 41461 Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: Preparing to generate the ALSA configuration file Nov 26 15:04:19 volumio.lufaan.nl systemd[1]: mpd.service: Succeeded. Nov 26 15:04:19 volumio.lufaan.nl systemd[1]: Stopped Music Player Daemon. Nov 26 15:04:19 volumio.lufaan.nl systemd[1]: Starting Music Player Daemon... Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: CoreStateMachine::pushState Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: CorePlayQueue::getTrack 0 Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::volumioPushState Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: [squeezelite_mc] Server discovery started Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: [squeezelite_mc] Player finder started Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-o squeezelite -C 1 -n \"volumio-sq\" -D 3:dop -f /tmp/squeezelite.log","card":"5","mixerType":"None","mixer":null} Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: Error: send ENETUNREACH 255.255.255.255:3483 Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: at doSend (dgram.js:714:16) Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: at afterDns (dgram.js:660:5) Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: errno: -101, Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: code: 'ENETUNREACH', Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: syscall: 'send', Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: address: '255.255.255.255', Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: port: 3483 Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: } Nov 26 15:04:19 volumio.lufaan.nl volumio[4293]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 15:04:19 volumio.lufaan.nl sudo[4514]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 15:04:19 volumio.lufaan.nl sudo[4514]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:19 volumio.lufaan.nl sudo[4514]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:19 volumio.lufaan.nl sudo[4517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Nov 26 15:04:19 volumio.lufaan.nl sudo[4517]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:19 volumio.lufaan.nl sudo[4517]: pam_unix(sudo:session): session closed for user root Nov 26 15:04:20 volumio.lufaan.nl sudo[4530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 15:03 Nov 26 15:04:20 volumio.lufaan.nl sudo[4530]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 15:04:20 volumio.lufaan.nl dhcpcd[796]: eth0: leased 192.168.178.100 for infinity Nov 26 15:04:20 volumio.lufaan.nl dhcpcd[796]: eth0: adding route to 192.168.178.0/24 Nov 26 15:04:20 volumio.lufaan.nl dhcpcd[796]: eth0: adding default route via 192.168.178.253 Nov 26 15:04:20 volumio.lufaan.nl avahi-daemon[724]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.100. Nov 26 15:04:20 volumio.lufaan.nl avahi-daemon[724]: New relevant interface eth0.IPv4 for mDNS. Nov 26 15:04:20 volumio.lufaan.nl avahi-daemon[724]: Registering new address record for 192.168.178.100 on eth0.IPv4. PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 10:15:17 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="49ee0b71bdee95489f79b31a5db4cbdb"