-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-07-14 17:40:03 CEST. -- Jul 14 17:39:44 arwen systemd[1]: Starting Daily apt download activities... Jul 14 17:39:46 arwen systemd[1]: apt-daily.service: Succeeded. Jul 14 17:39:46 arwen systemd[1]: Started Daily apt download activities. Jul 14 17:39:46 arwen volumio[921]: info: MYVOLUMIO Environment detected Jul 14 17:39:46 arwen systemd[1]: Starting Daily apt upgrade and clean activities... Jul 14 17:39:47 arwen volumio[921]: info: Plugin folders cleanup Jul 14 17:39:47 arwen volumio[921]: info: Scanning into folder /volumio/app/plugins/ Jul 14 17:39:47 arwen volumio[921]: info: Scanning category audio_interface Jul 14 17:39:47 arwen volumio[921]: info: Scanning category miscellanea Jul 14 17:39:47 arwen volumio[921]: info: Scanning category music_service Jul 14 17:39:47 arwen volumio[921]: info: Scanning category plugins.json Jul 14 17:39:47 arwen volumio[921]: info: Scanning category system_controller Jul 14 17:39:47 arwen volumio[921]: info: Scanning category user_interface Jul 14 17:39:47 arwen volumio[921]: info: Scanning into folder /data/plugins/ Jul 14 17:39:47 arwen volumio[921]: info: Scanning category music_service Jul 14 17:39:47 arwen volumio[921]: info: Plugin folders cleanup completed Jul 14 17:39:47 arwen volumio[921]: info: ------------------------------------------- Jul 14 17:39:47 arwen volumio[921]: info: ----- Core plugins startup ---- Jul 14 17:39:47 arwen volumio[921]: info: ------------------------------------------- Jul 14 17:39:47 arwen volumio[921]: info: Loading plugins from folder /volumio/app/plugins/ Jul 14 17:39:47 arwen volumio[921]: info: Adding plugin upnp to MyMusic Plugins Jul 14 17:39:47 arwen volumio[921]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 14 17:39:47 arwen volumio[921]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 14 17:39:47 arwen volumio[921]: info: Loading plugins from folder /data/plugins/ Jul 14 17:39:47 arwen volumio[921]: info: Loading plugin "system"... Jul 14 17:39:47 arwen volumio[921]: info: Loading plugin "appearance"... Jul 14 17:39:48 arwen systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 14 17:39:48 arwen systemd[1]: Started Daily apt upgrade and clean activities. Jul 14 17:39:49 arwen volumio[921]: info: Loading plugin "network"... Jul 14 17:39:50 arwen volumio[921]: info: Refreshing Cached IP Addresses Jul 14 17:39:50 arwen sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 14 17:39:50 arwen sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:50 arwen sudo[1061]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "services"... Jul 14 17:39:50 arwen sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 17:39:50 arwen sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:50 arwen sudo[1063]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "alsa_controller"... Jul 14 17:39:50 arwen sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 14 17:39:50 arwen sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:50 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "wizard"... Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "networkfs"... Jul 14 17:39:50 arwen volumio[921]: info: Starting Udev Watcher for removable devices Jul 14 17:39:50 arwen sudo[1074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,ro,noatime,intr 192.168.2.251:/volume1/music /mnt/NAS/Imladris Jul 14 17:39:50 arwen sudo[1074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:50 arwen volumio[921]: info: Ignoring mount for partition: boot Jul 14 17:39:50 arwen volumio[921]: info: Ignoring mount for partition: volumio Jul 14 17:39:50 arwen volumio[921]: info: Ignoring mount for partition: volumio_data Jul 14 17:39:50 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 17:39:50 arwen kernel: nfs: Deprecated parameter 'intr' Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "volumio_command_line_client"... Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "upnp"... Jul 14 17:39:50 arwen kernel: nfs: Deprecated parameter 'intr' Jul 14 17:39:50 arwen volumio[921]: info: [1720971590635] Starting Upmpd Daemon Jul 14 17:39:50 arwen kernel: nfs: Deprecated parameter 'intr' Jul 14 17:39:50 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "my_music"... Jul 14 17:39:50 arwen volumio[921]: info: Loading plugin "mpd"... Jul 14 17:39:50 arwen systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Jul 14 17:39:50 arwen systemd[1]: Starting Preprocess NFS configuration... Jul 14 17:39:50 arwen systemd[1]: nfs-config.service: Succeeded. Jul 14 17:39:50 arwen systemd[1]: Started Preprocess NFS configuration. Jul 14 17:39:51 arwen systemd[1]: Starting Notify NFS peers of a restart... Jul 14 17:39:51 arwen systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Jul 14 17:39:51 arwen sm-notify[1086]: Version 1.3.3 starting Jul 14 17:39:51 arwen systemd[1]: rpc-statd-notify.service: Succeeded. Jul 14 17:39:51 arwen systemd[1]: Started Notify NFS peers of a restart. Jul 14 17:39:51 arwen rpc.statd[1088]: Version 1.3.3 starting Jul 14 17:39:51 arwen rpc.statd[1088]: Flags: TI-RPC Jul 14 17:39:51 arwen systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Jul 14 17:39:51 arwen kernel: nfs: Deprecated parameter 'intr' Jul 14 17:39:51 arwen sudo[1074]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:51 arwen volumio[921]: info: Loading plugin "upnp_browser"... Jul 14 17:39:52 arwen volumio[921]: info: Loading plugin "alarm-clock"... Jul 14 17:39:52 arwen volumio[921]: info: Loading plugin "airplay_emulation"... Jul 14 17:39:52 arwen volumio[921]: info: Starting Shairport Sync Jul 14 17:39:52 arwen volumio[921]: info: Loading plugin "last_100"... Jul 14 17:39:52 arwen volumio[921]: info: Loading plugin "webradio"... Jul 14 17:39:53 arwen volumio[921]: info: Loading plugin "i2s_dacs"... Jul 14 17:39:53 arwen volumio[921]: info: Loading plugin "volumiodiscovery"... Jul 14 17:39:53 arwen volumio[921]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 14 17:39:53 arwen volumio[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 17:39:53 arwen volumio[921]: *** WARNING *** For more information see Jul 14 17:39:53 arwen node[921]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 14 17:39:53 arwen volumio[921]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 14 17:39:53 arwen volumio[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 17:39:53 arwen volumio[921]: *** WARNING *** For more information see Jul 14 17:39:53 arwen node[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 17:39:53 arwen node[921]: *** WARNING *** For more information see Jul 14 17:39:53 arwen node[921]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 14 17:39:53 arwen node[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 14 17:39:53 arwen node[921]: *** WARNING *** For more information see Jul 14 17:39:53 arwen volumio[921]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 14 17:39:53 arwen volumio[921]: info: Discovery: Started advertising with name: Arwen Jul 14 17:39:53 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 14 17:39:53 arwen volumio[921]: info: Plugin spop is not enabled Jul 14 17:39:53 arwen volumio[921]: info: Loading plugin "outputs"... Jul 14 17:39:53 arwen volumio[921]: info: Loading plugin "albumart"... Jul 14 17:39:53 arwen volumio[921]: info: Plugin example_plugin is not enabled Jul 14 17:39:53 arwen volumio[921]: info: Loading plugin "inputs"... Jul 14 17:39:53 arwen volumio[921]: info: Loading plugin "updater_comm"... Jul 14 17:39:53 arwen sudo[1066]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:54 arwen volumio[921]: info: Plugin mpdemulation is not enabled Jul 14 17:39:54 arwen volumio[921]: info: Loading plugin "rest_api"... Jul 14 17:39:54 arwen volumio[921]: info: Loading plugin "websocket"... Jul 14 17:39:54 arwen volumio[921]: info: Starting Socket.io Server version 2.3.0 Jul 14 17:39:54 arwen volumio[921]: info: Loading i18n strings for locale nl Jul 14 17:39:54 arwen volumio[921]: Updating browse sources language Jul 14 17:39:54 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 17:39:54 arwen volumio[921]: Forking 3 albumart workers Jul 14 17:39:54 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 17:39:54 arwen volumio[921]: info: CoreCommandRouter::initPlayerControls Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 17:39:55 arwen volumio[921]: Express server listening on port 3000 Jul 14 17:39:55 arwen volumio[921]: [Metrics] WebUI: 12s 299.42ms Jul 14 17:39:55 arwen volumio[921]: info: CoreStateMachine::resetVolumioState Jul 14 17:39:55 arwen volumio[921]: info: CoreStateMachine::getcurrentVolume Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::volumioRetrievevolume Jul 14 17:39:55 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 14 17:39:55 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 14 17:39:55 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 14 17:39:55 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 14 17:39:55 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 14 17:39:55 arwen volumio[921]: info: Reloading queue from file Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 17:39:55 arwen volumio[921]: info: CoreStateMachine::setRepeat true single undefined Jul 14 17:39:55 arwen volumio[921]: info: CoreStateMachine::pushState Jul 14 17:39:55 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::volumioPushState Jul 14 17:39:55 arwen volumio[921]: info: CoreStateMachine::setRandom false Jul 14 17:39:55 arwen volumio[921]: info: CoreStateMachine::pushState Jul 14 17:39:55 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 17:39:55 arwen volumio[921]: info: CoreCommandRouter::volumioPushState Jul 14 17:39:55 arwen volumio[921]: info: Setting Device type: Raspberry PI Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jul 14 17:39:56 arwen volumio[921]: info: Completed loading Core Plugins Jul 14 17:39:56 arwen volumio[921]: info: Preparing to generate the ALSA configuration file Jul 14 17:39:56 arwen volumio[921]: info: VolumeController:: Volume=83 Mute =false Jul 14 17:39:56 arwen volumio[921]: info: CoreStateMachine::pushState Jul 14 17:39:56 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::volumioPushState Jul 14 17:39:56 arwen volumio[921]: info: CoreStateMachine::updateTrackBlock Jul 14 17:39:56 arwen volumio[921]: info: CorePlayQueue::getTrackBlock Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::volumioRetrievevolume Jul 14 17:39:56 arwen volumio[921]: Starting albumart workers Jul 14 17:39:56 arwen volumio[921]: Starting albumart workers Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 14 17:39:56 arwen volumio[921]: Starting albumart workers Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jul 14 17:39:56 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Jul 14 17:39:56 arwen volumio[921]: info: Asound.conf file unchanged, so no further update is needed Jul 14 17:39:56 arwen volumio[921]: info: Output device has changed, restarting MPD Jul 14 17:39:56 arwen volumio[921]: info: Output device has changed, restarting Shairport Sync Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 17:39:56 arwen sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 14 17:39:56 arwen sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:56 arwen sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 14 17:39:56 arwen sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:56 arwen sudo[1137]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:56 arwen systemd[1]: Listening on mpd.socket. Jul 14 17:39:56 arwen systemd[1]: Starting Music Player Daemon... Jul 14 17:39:56 arwen volumio[921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 17:39:56 arwen volumio[921]: info: ___________ START PLUGINS ___________ Jul 14 17:39:56 arwen volumio[921]: info: ControllerMpd::onStart: Initializing MPD Jul 14 17:39:56 arwen volumio[921]: info: Creating MPD Configuration file Jul 14 17:39:56 arwen sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 14 17:39:56 arwen sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 17:39:56 arwen volumio[921]: info: [1720971596928] CoreMusicLibrary::Adding element Media Servers Jul 14 17:39:56 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 17:39:56 arwen systemd[1]: systemd-fsckd.service: Succeeded. Jul 14 17:39:56 arwen sudo[1147]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 17:39:57 arwen sudo[1145]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 14 17:39:57 arwen sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:57 arwen sudo[1145]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jul 14 17:39:57 arwen sudo[1145]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:57 arwen sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 14 17:39:57 arwen sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:57 arwen volumio[921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:57 arwen systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 14 17:39:57 arwen systemd[1]: mpd.service: Succeeded. Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 17:39:57 arwen systemd[1]: Stopped Music Player Daemon. Jul 14 17:39:57 arwen systemd[1]: Starting Music Player Daemon... Jul 14 17:39:57 arwen volumio[921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 17:39:57 arwen volumio[921]: info: [1720971597407] CoreMusicLibrary::Adding element Last_100 Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 17:39:57 arwen volumio[921]: info: [1720971597448] CoreMusicLibrary::Adding element Webradio Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 17:39:57 arwen volumio[921]: info: Initializing BBC Radios Jul 14 17:39:57 arwen sudo[1158]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 14 17:39:57 arwen sudo[1158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:57 arwen sudo[1158]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jul 14 17:39:57 arwen sudo[1158]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 17:39:57 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 17:39:57 arwen volumio[921]: info: Volumio Calling Home Jul 14 17:39:58 arwen volumio[921]: info: Discovery: adding 66fef2d7-3b8f-4207-8832-a5b6ecbb8c16 Jul 14 17:39:58 arwen volumio[921]: info: Discovery: Found device Arwen Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::volumioGetState Jul 14 17:39:58 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:58 arwen volumio[921]: info: Discovery: this is already registered, 66fef2d7-3b8f-4207-8832-a5b6ecbb8c16 Jul 14 17:39:58 arwen volumio[921]: info: Discovery: Found device Arwen Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::volumioGetState Jul 14 17:39:58 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:58 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Jul 14 17:39:58 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Jul 14 17:39:58 arwen volumio[921]: info: MPD Permissions set Jul 14 17:39:58 arwen volumio[921]: info: VolumeController:: Volume=83 Mute =false Jul 14 17:39:58 arwen volumio[921]: info: CoreStateMachine::pushState Jul 14 17:39:58 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::volumioPushState Jul 14 17:39:58 arwen volumio[921]: info: Volumio called home Jul 14 17:39:58 arwen volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 17:39:58 arwen volumio-remote-updater[599]: [2024-07-14 17:39:58] [connect] Successful connection Jul 14 17:39:58 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Jul 14 17:39:58 arwen volumio-remote-updater[599]: [2024-07-14 17:39:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1720971598 101 Jul 14 17:39:58 arwen volumio[921]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 19 Jul 14 17:39:58 arwen volumio[921]: info: Starting Shairport Sync Jul 14 17:39:58 arwen volumio[921]: info: Starting Shairport Sync Jul 14 17:39:58 arwen volumio[921]: info: Starting Shairport Sync Jul 14 17:39:58 arwen sudo[1209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 17:39:58 arwen sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:58 arwen sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 17:39:58 arwen sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 14 17:39:58 arwen sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:58 arwen sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:58 arwen volumio[921]: info: CoreCommandRouter::volumioGetState Jul 14 17:39:58 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:58 arwen systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 14 17:39:58 arwen systemd[1]: shairport-sync.service: Succeeded. Jul 14 17:39:58 arwen systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 14 17:39:59 arwen volumio[921]: info: CoreCommandRouter::volumioGetState Jul 14 17:39:59 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:39:59 arwen systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 14 17:39:59 arwen sudo[1211]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:59 arwen sudo[1209]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:59 arwen sudo[1214]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:59 arwen volumio[921]: info: Shairport-Sync Started Jul 14 17:39:59 arwen volumio[921]: Error adding Membership: Error: addMembership EINVAL Jul 14 17:39:59 arwen volumio[921]: info: Shairport-Sync Started Jul 14 17:39:59 arwen sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 14 17:39:59 arwen sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:59 arwen sudo[1224]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:59 arwen sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 17:39:59 arwen sudo[1226]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:39:59 arwen sudo[1226]: pam_unix(sudo:session): session closed for user root Jul 14 17:39:59 arwen volumio[921]: verbose: New Socket.io Connection to 192.168.2.181 from 192.168.2.139 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::volumioGetVisibleSources Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::volumioGetState Jul 14 17:40:00 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::volumioGetQueue Jul 14 17:40:00 arwen volumio[921]: info: CoreStateMachine::getQueue Jul 14 17:40:00 arwen volumio[921]: info: CorePlayQueue::getQueue Jul 14 17:40:00 arwen volumio[921]: info: Listing playlists Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 14 17:40:00 arwen volumio[921]: info: Received Get System Info Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 14 17:40:00 arwen volumio[921]: info: Discovery: Getting this device information Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::volumioGetState Jul 14 17:40:00 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::volumioGetState Jul 14 17:40:00 arwen volumio[921]: info: CorePlayQueue::getTrack 0 Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 14 17:40:00 arwen volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 14 17:40:00 arwen sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 14 17:40:00 arwen sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:40:00 arwen sudo[1230]: pam_unix(sudo:session): session closed for user root Jul 14 17:40:00 arwen sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 14 17:40:00 arwen sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:40:00 arwen sudo[1232]: pam_unix(sudo:session): session closed for user root Jul 14 17:40:00 arwen sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 14 17:40:00 arwen sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 17:40:01 arwen systemd[1]: Started UPnP Renderer front-end to MPD. Jul 14 17:40:01 arwen sudo[1236]: pam_unix(sudo:session): session closed for user root Jul 14 17:40:01 arwen volumio[921]: info: Upmpdcli Daemon Started Jul 14 17:40:01 arwen volumio[921]: info: Preload queue cleared Jul 14 17:40:01 arwen volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 14 17:40:01 arwen volumio[921]: info: CoreStateMachine::ClearQueue Jul 14 17:40:01 arwen volumio[921]: info: CoreStateMachine::stop Jul 14 17:40:01 arwen volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 17:40:01 arwen volumio[921]: info: CorePlayQueue::clearPlayQueue Jul 14 17:40:01 arwen volumio[921]: info: CorePlayQueue::saveQueue Jul 14 17:40:01 arwen volumio[921]: info: CoreCommandRouter::volumioPushQueue Jul 14 17:40:01 arwen volumio[921]: info: CoreStateMachine::addQueueItems Jul 14 17:40:01 arwen volumio[921]: info: CorePlayQueue::addQueueItems Jul 14 17:40:01 arwen volumio[921]: info: Preload queue cleared Jul 14 17:40:01 arwen volumio[921]: info: Adding Item to queue: music-library/NAS/Imladris/Flac/Devin Townsend/2015 - Devin Townsend • Ziltoid Live At The Royal Albert Hall 2015 [EU Limited Edition] [3CD+2DVD+BLURAY]/CD1/01. Z².flac Jul 14 17:40:01 arwen volumio[921]: info: Exploding uri music-library/NAS/Imladris/Flac/Devin Townsend/2015 - Devin Townsend • Ziltoid Live At The Royal Albert Hall 2015 [EU Limited Edition] [3CD+2DVD+BLURAY]/CD1/01. Z².flac in service mpd Jul 14 17:40:01 arwen volumio[921]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 17:40:01 arwen volumio[921]: TypeError: Cannot read property 'then' of undefined Jul 14 17:40:01 arwen volumio[921]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Jul 14 17:40:01 arwen volumio[921]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Jul 14 17:40:01 arwen volumio[921]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1365:16) Jul 14 17:40:01 arwen volumio[921]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jul 14 17:40:01 arwen volumio[921]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jul 14 17:40:01 arwen volumio[921]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jul 14 17:40:01 arwen volumio[921]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Jul 14 17:40:01 arwen volumio[921]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Jul 14 17:40:01 arwen volumio[921]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:483:17) Jul 14 17:40:01 arwen volumio[921]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:139:33) Jul 14 17:40:01 arwen volumio[921]: at Socket.emit (events.js:315:20) Jul 14 17:40:01 arwen volumio[921]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 14 17:40:01 arwen volumio[921]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 14 17:40:01 arwen volumio[921]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 17:40:02 arwen systemd[1]: systemd-hostnamed.service: Succeeded. Jul 14 17:40:03 arwen mpd[1168]: Jul 14 17:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 14 17:40:03 arwen sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 17:39 Jul 14 17:40:03 arwen sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"