-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2025-05-12 17:48:15 CEST. -- May 12 17:47:14 volumio volumio[898]: info: Get:60 http://raspbian.mirror.garr.it/mirrors/raspbian/raspbian buster/main armhf timgm6mb-soundfont all 1.3-2 [5421 kB] May 12 17:47:16 volumio volumio[898]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 May 12 17:47:16 volumio volumio[898]: info: CoreCommandRouter::volumioGetState May 12 17:47:17 volumio volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources May 12 17:47:17 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 17:47:17 volumio volumio[898]: info: CoreCommandRouter::volumioGetQueue May 12 17:47:17 volumio volumio[898]: info: CoreStateMachine::getQueue May 12 17:47:17 volumio volumio[898]: info: CorePlayQueue::getQueue May 12 17:47:17 volumio volumio[898]: info: Listing playlists May 12 17:47:17 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 17:47:29 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 17:47:29 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 12 17:47:32 volumio sudo[7704]: pam_unix(sudo:session): session closed for user root May 12 17:47:32 volumio volumio[898]: info: Fetched 41.4 MB in 8min 14s (83.8 kB/s) May 12 17:47:32 volumio sudo[8938]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 12 17:47:32 volumio sudo[8938]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:32 volumio systemd[1]: Reloading. May 12 17:47:33 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 12 17:47:33 volumio sudo[8938]: pam_unix(sudo:session): session closed for user root May 12 17:47:33 volumio sudo[8955]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/user_interface/peppymeterbasic/startpeppymeterbasic.sh May 12 17:47:33 volumio sudo[8955]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:33 volumio sudo[8955]: pam_unix(sudo:session): session closed for user root May 12 17:47:33 volumio sudo[6820]: pam_unix(sudo:session): session closed for user root May 12 17:47:33 volumio volumio[898]: info: Install script completed May 12 17:47:33 volumio volumio[898]: info: Adding reference to registry May 12 17:47:33 volumio volumio[898]: info: Done installing plugin. May 12 17:47:33 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 17:47:33 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 12 17:47:33 volumio volumio[898]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so May 12 17:47:33 volumio volumio[898]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so.0 May 12 17:47:33 volumio volumio[898]: info: Folder /tmp/plugins removed May 12 17:47:33 volumio volumio[898]: info: Folder /tmp/downloaded_plugin.zip removed May 12 17:47:33 volumio volumio[898]: info: Folder /data/temp removed May 12 17:47:33 volumio volumio[898]: Plugin install end detected on script May 12 17:47:36 volumio volumio[898]: info: Enabling plugin peppyspectrum May 12 17:47:36 volumio volumio[898]: info: Loading plugin "peppyspectrum"... May 12 17:47:37 volumio volumio[898]: info: Preparing to generate the ALSA configuration file May 12 17:47:37 volumio volumio[898]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf May 12 17:47:37 volumio volumio[898]: info: Reading ALSA contributions from plugins. May 12 17:47:37 volumio volumio[898]: info: Asound.conf file written May 12 17:47:37 volumio sudo[8958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 12 17:47:37 volumio sudo[8958]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:37 volumio sudo[8958]: pam_unix(sudo:session): session closed for user root May 12 17:47:37 volumio volumio[898]: No state is present for card b1 May 12 17:47:37 volumio volumio[898]: /usr/share/alsa/init/bcm2835:14: control element not found May 12 17:47:37 volumio volumio[898]: No state is present for card b1 May 12 17:47:37 volumio volumio[898]: No state is present for card Headphones May 12 17:47:37 volumio volumio[898]: /usr/share/alsa/init/bcm2835:20: control element not found May 12 17:47:37 volumio volumio[898]: No state is present for card Headphones May 12 17:47:37 volumio volumio[898]: No state is present for card Katana May 12 17:47:37 volumio volumio[898]: Found hardware: "Allo_Katana" "" "" "" "" May 12 17:47:37 volumio volumio[898]: Hardware is initialized using a generic method May 12 17:47:37 volumio volumio[898]: No state is present for card Katana May 12 17:47:37 volumio volumio[898]: info: Output device has changed, restarting MPD May 12 17:47:37 volumio sudo[8963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 17:47:37 volumio volumio[898]: info: Output device has changed, restarting Shairport Sync May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:37 volumio sudo[8963]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:37 volumio sudo[8963]: pam_unix(sudo:session): session closed for user root May 12 17:47:37 volumio sudo[8965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 17:47:37 volumio sudo[8965]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:37 volumio systemd[1]: Stopping Music Player Daemon... May 12 17:47:37 volumio volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 17:47:37 volumio volumio[898]: info: PLUGIN START: peppyspectrum May 12 17:47:37 volumio systemd[1]: mpd.service: Succeeded. May 12 17:47:37 volumio systemd[1]: Stopped Music Player Daemon. May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 12 17:47:37 volumio volumio[898]: info: Preparing to generate the ALSA configuration file May 12 17:47:37 volumio volumio[898]: info: Done. May 12 17:47:37 volumio volumio[898]: info: MPD Permissions set May 12 17:47:37 volumio volumio[898]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf May 12 17:47:37 volumio volumio[898]: info: Reading ALSA contributions from plugins. May 12 17:47:37 volumio systemd[1]: Starting Music Player Daemon... May 12 17:47:37 volumio volumio[898]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:37 volumio sudo[8971]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 12 17:47:37 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:37 volumio sudo[8971]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:37 volumio sudo[8971]: pam_unix(sudo:session): session closed for user root May 12 17:47:37 volumio volumio[898]: info: Starting Shairport Sync May 12 17:47:38 volumio sudo[8994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 17:47:38 volumio sudo[8994]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:38 volumio volumio[898]: info: Asound.conf file unchanged, so no further update is needed May 12 17:47:38 volumio volumio[898]: info: Output device has changed, restarting MPD May 12 17:47:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 17:47:38 volumio systemd[1]: shairport-sync.service: Succeeded. May 12 17:47:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 17:47:38 volumio volumio[898]: info: Output device has changed, restarting Shairport Sync May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 17:47:38 volumio sudo[8994]: pam_unix(sudo:session): session closed for user root May 12 17:47:38 volumio sudo[8997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 17:47:38 volumio sudo[9000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 17:47:38 volumio sudo[8997]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:38 volumio sudo[9000]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:38 volumio sudo[8997]: pam_unix(sudo:session): session closed for user root May 12 17:47:38 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 12 17:47:38 volumio systemd[1]: mpd.service: Succeeded. May 12 17:47:38 volumio systemd[1]: Stopped Music Player Daemon. May 12 17:47:38 volumio volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 17:47:38 volumio systemd[1]: Starting Music Player Daemon... May 12 17:47:38 volumio volumio[898]: info: Enabling plugin peppymeterbasic May 12 17:47:38 volumio volumio[898]: info: Loading plugin "peppymeterbasic"... May 12 17:47:38 volumio sudo[9006]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 12 17:47:38 volumio sudo[9006]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:38 volumio sudo[9006]: pam_unix(sudo:session): session closed for user root May 12 17:47:38 volumio volumio[898]: info: Preparing to generate the ALSA configuration file May 12 17:47:38 volumio volumio[898]: info: MPD Permissions set May 12 17:47:38 volumio volumio[898]: info: Shairport-Sync Started May 12 17:47:38 volumio volumio[898]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf May 12 17:47:38 volumio volumio[898]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf May 12 17:47:38 volumio volumio[898]: info: Reading ALSA contributions from plugins. May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:38 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:38 volumio volumio[898]: info: Starting Shairport Sync May 12 17:47:38 volumio volumio[898]: info: Asound.conf file written May 12 17:47:38 volumio sudo[9020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 17:47:38 volumio sudo[9020]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:38 volumio sudo[9022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 12 17:47:38 volumio sudo[9022]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 17:47:38 volumio sudo[9022]: pam_unix(sudo:session): session closed for user root May 12 17:47:38 volumio systemd[1]: shairport-sync.service: Succeeded. May 12 17:47:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 17:47:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 17:47:39 volumio volumio[898]: No state is present for card b1 May 12 17:47:39 volumio volumio[898]: /usr/share/alsa/init/bcm2835:14: control element not found May 12 17:47:39 volumio volumio[898]: No state is present for card b1 May 12 17:47:39 volumio volumio[898]: No state is present for card Headphones May 12 17:47:39 volumio volumio[898]: /usr/share/alsa/init/bcm2835:20: control element not found May 12 17:47:39 volumio volumio[898]: No state is present for card Headphones May 12 17:47:39 volumio volumio[898]: No state is present for card Katana May 12 17:47:39 volumio volumio[898]: Found hardware: "Allo_Katana" "" "" "" "" May 12 17:47:39 volumio volumio[898]: Hardware is initialized using a generic method May 12 17:47:39 volumio volumio[898]: No state is present for card Katana May 12 17:47:39 volumio volumio[898]: info: Output device has changed, restarting MPD May 12 17:47:39 volumio sudo[9020]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio volumio[898]: info: Output device has changed, restarting Shairport Sync May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:39 volumio sudo[9034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 17:47:39 volumio sudo[9034]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio sudo[9034]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio sudo[8221]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio sudo[9037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 17:47:39 volumio sudo[9037]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 12 17:47:39 volumio systemd[1]: mpd.service: Succeeded. May 12 17:47:39 volumio systemd[1]: Stopped Music Player Daemon. May 12 17:47:39 volumio volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 17:47:39 volumio volumio[898]: info: PLUGIN START: peppymeterbasic May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 12 17:47:39 volumio volumio[898]: info: Preparing to generate the ALSA configuration file May 12 17:47:39 volumio volumio[898]: info: Done. May 12 17:47:39 volumio volumio[898]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf May 12 17:47:39 volumio volumio[898]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf May 12 17:47:39 volumio volumio[898]: info: Reading ALSA contributions from plugins. May 12 17:47:39 volumio volumio[898]: info: MPD Permissions set May 12 17:47:39 volumio volumio[898]: info: Install script completed May 12 17:47:39 volumio systemd[1]: Starting Music Player Daemon... May 12 17:47:39 volumio volumio[898]: info: Adding reference to registry May 12 17:47:39 volumio volumio[898]: info: Done installing plugin. May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 12 17:47:39 volumio volumio[898]: info: Shairport-Sync Started May 12 17:47:39 volumio volumio[898]: info: Folder /tmp/plugins removed May 12 17:47:39 volumio volumio[898]: info: Folder /data/temp removed May 12 17:47:39 volumio volumio[898]: info: Folder /tmp/downloaded_plugin.zip removed May 12 17:47:39 volumio volumio[898]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio sudo[9047]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 12 17:47:39 volumio sudo[9047]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio sudo[9047]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio volumio[898]: info: Starting Shairport Sync May 12 17:47:39 volumio volumio[898]: info: Asound.conf file unchanged, so no further update is needed May 12 17:47:39 volumio sudo[9057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 17:47:39 volumio volumio[898]: info: Output device has changed, restarting MPD May 12 17:47:39 volumio sudo[9057]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 17:47:39 volumio volumio[898]: info: Output device has changed, restarting Shairport Sync May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:39 volumio systemd[1]: shairport-sync.service: Succeeded. May 12 17:47:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 17:47:39 volumio sudo[9060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 17:47:39 volumio sudo[9060]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio sudo[9062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 17:47:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 17:47:39 volumio sudo[9062]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio sudo[9060]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 17:47:39 volumio sudo[9057]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 12 17:47:39 volumio systemd[1]: mpd.service: Succeeded. May 12 17:47:39 volumio systemd[1]: Stopped Music Player Daemon. May 12 17:47:39 volumio systemd[1]: Starting Music Player Daemon... May 12 17:47:39 volumio volumio[898]: info: MPD Permissions set May 12 17:47:39 volumio volumio[898]: info: Shairport-Sync Started May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:47:39 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:47:39 volumio volumio[898]: info: Starting Shairport Sync May 12 17:47:39 volumio sudo[9080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 17:47:39 volumio sudo[9080]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 17:47:39 volumio systemd[1]: shairport-sync.service: Succeeded. May 12 17:47:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 17:47:39 volumio sudo[9072]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 12 17:47:39 volumio sudo[9072]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:47:39 volumio sudo[9072]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 17:47:39 volumio sudo[9080]: pam_unix(sudo:session): session closed for user root May 12 17:47:39 volumio volumio[898]: info: Shairport-Sync Started May 12 17:47:41 volumio mpd[9084]: May 12 17:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 12 17:47:41 volumio systemd[1]: Started Music Player Daemon. May 12 17:47:41 volumio sudo[8965]: pam_unix(sudo:session): session closed for user root May 12 17:47:41 volumio sudo[9062]: pam_unix(sudo:session): session closed for user root May 12 17:47:41 volumio sudo[9000]: pam_unix(sudo:session): session closed for user root May 12 17:47:41 volumio sudo[9037]: pam_unix(sudo:session): session closed for user root May 12 17:47:41 volumio volumio[898]: error: MPD error: The expression evaluated to a falsy value: May 12 17:47:41 volumio volumio[898]: assert.ok(self.idling) May 12 17:47:41 volumio volumio[898]: error: The expression evaluated to a falsy value: May 12 17:47:41 volumio volumio[898]: assert.ok(self.idling) May 12 17:47:41 volumio volumio[898]: error: MPD error: The expression evaluated to a falsy value: May 12 17:47:41 volumio volumio[898]: assert.ok(self.idling) May 12 17:47:41 volumio volumio[898]: error: The expression evaluated to a falsy value: May 12 17:47:41 volumio volumio[898]: assert.ok(self.idling) May 12 17:47:41 volumio volumio[898]: error: MPD error: The expression evaluated to a falsy value: May 12 17:47:41 volumio volumio[898]: assert.ok(self.idling) May 12 17:47:41 volumio volumio[898]: error: The expression evaluated to a falsy value: May 12 17:47:41 volumio volumio[898]: assert.ok(self.idling) May 12 17:47:41 volumio volumio[898]: info: Enabling plugin now_playing May 12 17:47:41 volumio volumio[898]: info: Loading plugin "now_playing"... May 12 17:47:41 volumio volumio[898]: error: !!!! WARNING !!!! May 12 17:47:41 volumio volumio[898]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' May 12 17:47:41 volumio volumio[898]: Require stack: May 12 17:47:41 volumio volumio[898]: - /data/plugins/user_interface/now_playing/dist/index.js May 12 17:47:41 volumio volumio[898]: - /volumio/app/pluginmanager.js May 12 17:47:41 volumio volumio[898]: - /volumio/app/index.js May 12 17:47:41 volumio volumio[898]: - /volumio/index.js May 12 17:47:41 volumio volumio[898]: error: Stack trace: Error: Cannot find module 'geo-tz' May 12 17:47:41 volumio volumio[898]: Require stack: May 12 17:47:41 volumio volumio[898]: - /data/plugins/user_interface/now_playing/dist/index.js May 12 17:47:41 volumio volumio[898]: - /volumio/app/pluginmanager.js May 12 17:47:41 volumio volumio[898]: - /volumio/app/index.js May 12 17:47:41 volumio volumio[898]: - /volumio/index.js May 12 17:47:41 volumio volumio[898]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) May 12 17:47:41 volumio volumio[898]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) May 12 17:47:41 volumio volumio[898]: at Module.require (internal/modules/cjs/loader.js:952:19) May 12 17:47:41 volumio volumio[898]: at require (internal/modules/cjs/helpers.js:88:18) May 12 17:47:41 volumio volumio[898]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) May 12 17:47:41 volumio volumio[898]: at Module._compile (internal/modules/cjs/loader.js:1063:30) May 12 17:47:41 volumio volumio[898]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) May 12 17:47:41 volumio volumio[898]: at Module.load (internal/modules/cjs/loader.js:928:32) May 12 17:47:41 volumio volumio[898]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) May 12 17:47:41 volumio volumio[898]: at Module.require (internal/modules/cjs/loader.js:952:19) May 12 17:47:41 volumio volumio[898]: at require (internal/modules/cjs/helpers.js:88:18) May 12 17:47:41 volumio volumio[898]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) May 12 17:47:41 volumio volumio[898]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 12 17:47:41 volumio volumio[898]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 12 17:47:41 volumio volumio[898]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 12 17:47:41 volumio volumio[898]: error: !!!! WARNING !!!! May 12 17:47:41 volumio volumio[898]: info: Done. May 12 17:47:41 volumio volumio[898]: error: updateQueue error: null May 12 17:47:53 volumio volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 17:47:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 17:47:55 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 12 17:48:01 volumio volumio[898]: info: Starting Uninstall of plugin user_interface - now_playing May 12 17:48:01 volumio volumio[898]: info: Uninstalling plugin now_playing May 12 17:48:07 volumio volumio[898]: info: Enabling plugin now_playing May 12 17:48:07 volumio volumio[898]: info: Loading plugin "now_playing"... May 12 17:48:07 volumio volumio[898]: error: !!!! WARNING !!!! May 12 17:48:07 volumio volumio[898]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' May 12 17:48:07 volumio volumio[898]: Require stack: May 12 17:48:07 volumio volumio[898]: - /data/plugins/user_interface/now_playing/dist/index.js May 12 17:48:07 volumio volumio[898]: - /volumio/app/pluginmanager.js May 12 17:48:07 volumio volumio[898]: - /volumio/app/index.js May 12 17:48:07 volumio volumio[898]: - /volumio/index.js May 12 17:48:07 volumio volumio[898]: error: Stack trace: Error: Cannot find module 'geo-tz' May 12 17:48:07 volumio volumio[898]: Require stack: May 12 17:48:07 volumio volumio[898]: - /data/plugins/user_interface/now_playing/dist/index.js May 12 17:48:07 volumio volumio[898]: - /volumio/app/pluginmanager.js May 12 17:48:07 volumio volumio[898]: - /volumio/app/index.js May 12 17:48:07 volumio volumio[898]: - /volumio/index.js May 12 17:48:07 volumio volumio[898]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) May 12 17:48:07 volumio volumio[898]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) May 12 17:48:07 volumio volumio[898]: at Module.require (internal/modules/cjs/loader.js:952:19) May 12 17:48:07 volumio volumio[898]: at require (internal/modules/cjs/helpers.js:88:18) May 12 17:48:07 volumio volumio[898]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) May 12 17:48:07 volumio volumio[898]: at Module._compile (internal/modules/cjs/loader.js:1063:30) May 12 17:48:07 volumio volumio[898]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) May 12 17:48:07 volumio volumio[898]: at Module.load (internal/modules/cjs/loader.js:928:32) May 12 17:48:07 volumio volumio[898]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) May 12 17:48:07 volumio volumio[898]: at Module.require (internal/modules/cjs/loader.js:952:19) May 12 17:48:07 volumio volumio[898]: at require (internal/modules/cjs/helpers.js:88:18) May 12 17:48:07 volumio volumio[898]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) May 12 17:48:07 volumio volumio[898]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 12 17:48:07 volumio volumio[898]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 12 17:48:07 volumio volumio[898]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 12 17:48:07 volumio volumio[898]: error: !!!! WARNING !!!! May 12 17:48:07 volumio volumio[898]: info: Error: TypeError: Cannot read property 'printToastMessage' of null May 12 17:48:15 volumio volumio[898]: info: CoreCommandRouter::volumioStop May 12 17:48:15 volumio volumio[898]: info: CoreStateMachine::stop May 12 17:48:15 volumio volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 17:48:15 volumio volumio[898]: info: CoreStateMachine::stPlaybackTimer May 12 17:48:15 volumio volumio[898]: info: CoreStateMachine::updateTrackBlock May 12 17:48:15 volumio volumio[898]: info: CorePlayQueue::getTrackBlock May 12 17:48:15 volumio volumio[898]: info: CoreStateMachine::pushState May 12 17:48:15 volumio volumio[898]: info: CorePlayQueue::getTrack 0 May 12 17:48:15 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:48:15 volumio volumio[898]: info: CoreCommandRouter::volumioPushState May 12 17:48:15 volumio volumio[898]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 17:48:15 volumio volumio[898]: TypeError: Cannot read property 'pushState' of null May 12 17:48:15 volumio volumio[898]: at /volumio/app/index.js:326:32 May 12 17:48:15 volumio volumio[898]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) May 12 17:48:15 volumio volumio[898]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) May 12 17:48:15 volumio volumio[898]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) May 12 17:48:15 volumio volumio[898]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:530:22) May 12 17:48:15 volumio volumio[898]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1243:12) May 12 17:48:15 volumio volumio[898]: at CoreCommandRouter.volumioStop (/volumio/app/index.js:91:28) May 12 17:48:15 volumio volumio[898]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:262:33) May 12 17:48:15 volumio volumio[898]: at Socket.emit (events.js:315:20) May 12 17:48:15 volumio volumio[898]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 12 17:48:15 volumio volumio[898]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 12 17:48:15 volumio volumio[898]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 17:48:15 volumio sudo[9148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-12 17:47 May 12 17:48:15 volumio sudo[9148]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"