-- Logs begin at Thu 2019-02-14 11:12:01 CET, end at Mon 2025-06-23 20:54:15 CEST. -- Jun 23 20:53:00 ciucalumio ntpd[852]: receive: Unexpected origin timestamp 0xec04210a.a28ea0a2 does not match aorg 0000000000.00000000 from server@185.19.184.35 xmt 0xec04210c.a4053176 Jun 23 20:53:00 ciucalumio ntpd[852]: receive: Unexpected origin timestamp 0xec04210a.a28cc1d5 does not match aorg 0000000000.00000000 from server@212.45.144.3 xmt 0xec04210c.a3d7eb47 Jun 23 20:53:00 ciucalumio ntpd[852]: receive: Unexpected origin timestamp 0xec04210a.a28a7382 does not match aorg 0000000000.00000000 from server@37.247.53.178 xmt 0xec04210c.a3d37a18 Jun 23 20:53:00 ciucalumio ntpd[852]: receive: Unexpected origin timestamp 0xec04210a.a2895808 does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xec04210c.a6adb7c1 Jun 23 20:53:00 ciucalumio ntpd[852]: receive: Unexpected origin timestamp 0xec04210a.a282f1aa does not match aorg 0000000000.00000000 from server@93.94.88.51 xmt 0xec04210c.a6db53cf Jun 23 20:53:02 ciucalumio volumio[798]: info: Loading plugin "outputs"... Jun 23 20:53:02 ciucalumio volumio[798]: info: Loading plugin "albumart"... Jun 23 20:53:02 ciucalumio volumio[798]: info: Plugin example_plugin is not enabled Jun 23 20:53:02 ciucalumio volumio[798]: info: Loading plugin "inputs"... Jun 23 20:53:02 ciucalumio volumio[798]: info: Loading plugin "updater_comm"... Jun 23 20:53:02 ciucalumio volumio[798]: info: Plugin mpdemulation is not enabled Jun 23 20:53:02 ciucalumio volumio[798]: info: Loading plugin "rest_api"... Jun 23 20:53:02 ciucalumio volumio[798]: info: Loading plugin "websocket"... Jun 23 20:53:02 ciucalumio volumio[798]: info: Starting Socket.io Server version 2.3.0 Jun 23 20:53:02 ciucalumio volumio[798]: info: Loading plugin "fusiondsp"... Jun 23 20:53:02 ciucalumio volumio[798]: Forking 3 albumart workers Jun 23 20:53:03 ciucalumio volumio[798]: info: Applying required configuration parameters for plugin fusiondsp Jun 23 20:53:03 ciucalumio volumio[798]: info: Loading plugin "Systeminfo"... Jun 23 20:53:03 ciucalumio volumio[798]: Starting albumart workers Jun 23 20:53:03 ciucalumio volumio[798]: Starting albumart workers Jun 23 20:53:03 ciucalumio volumio[798]: Starting albumart workers Jun 23 20:53:04 ciucalumio volumio[798]: info: Loading plugin "peppymeterbasic"... Jun 23 20:53:04 ciucalumio volumio[798]: info: Loading plugin "touch_display"... Jun 23 20:53:05 ciucalumio volumio[798]: info: Applying required configuration parameters for plugin touch_display Jun 23 20:53:05 ciucalumio volumio[798]: info: Loading i18n strings for locale it Jun 23 20:53:05 ciucalumio volumio[798]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jun 23 20:53:05 ciucalumio volumio[798]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jun 23 20:53:05 ciucalumio volumio[798]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 23 20:53:05 ciucalumio volumio[798]: Updating browse sources language Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::initPlayerControls Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: Express server listening on port 3000 Jun 23 20:53:05 ciucalumio volumio[798]: [Metrics] WebUI: 12s 279.14ms Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreStateMachine::resetVolumioState Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreStateMachine::getcurrentVolume Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::volumioRetrievevolume Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreStateMachine::pushState Jun 23 20:53:05 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::volumioPushState Jun 23 20:53:05 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:05 ciucalumio volumio[798]: info: Volumio Network Manager: Network status updated: 1 Jun 23 20:53:06 ciucalumio volumio[798]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 23 20:53:06 ciucalumio volumio[798]: info: Reloading queue from file Jun 23 20:53:06 ciucalumio volumio[798]: info: Setting Device type: Raspberry PI Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreStateMachine::setRepeat null single undefined Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreStateMachine::pushState Jun 23 20:53:06 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::volumioPushState Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreStateMachine::setRandom null Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreStateMachine::pushState Jun 23 20:53:06 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::volumioPushState Jun 23 20:53:06 ciucalumio volumio[798]: info: Completed loading Core Plugins Jun 23 20:53:06 ciucalumio volumio[798]: info: Preparing to generate the ALSA configuration file Jun 23 20:53:06 ciucalumio volumio[798]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 23 20:53:06 ciucalumio volumio[798]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jun 23 20:53:06 ciucalumio volumio[798]: info: Reading ALSA contributions from plugins. Jun 23 20:53:06 ciucalumio volumio[798]: info: Asound.conf file unchanged, so no further update is needed Jun 23 20:53:06 ciucalumio volumio[798]: info: Output device has changed, restarting MPD Jun 23 20:53:06 ciucalumio volumio[798]: info: Output device has changed, restarting Shairport Sync Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:06 ciucalumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:53:06 ciucalumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio sudo[1162]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:06 ciucalumio sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:53:06 ciucalumio sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio systemd[1]: Stopping Music Player Daemon... Jun 23 20:53:06 ciucalumio volumio[798]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:53:06 ciucalumio volumio[798]: info: ___________ START PLUGINS ___________ Jun 23 20:53:06 ciucalumio volumio[798]: info: ControllerMpd::onStart: Initializing MPD Jun 23 20:53:06 ciucalumio volumio[798]: info: Creating MPD Configuration file Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 20:53:06 ciucalumio sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:53:06 ciucalumio volumio[798]: info: [1750704786377] CoreMusicLibrary::Adding element Server multimediali Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:53:06 ciucalumio sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio sudo[1171]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:06 ciucalumio sudo[1173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:53:06 ciucalumio sudo[1173]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:06 ciucalumio volumio[798]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:06 ciucalumio volumio[798]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:53:06 ciucalumio volumio[798]: info: [1750704786498] CoreMusicLibrary::Adding element Last_100 Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:53:06 ciucalumio volumio[798]: info: [1750704786502] CoreMusicLibrary::Adding element Webradio Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:53:06 ciucalumio volumio[798]: info: Initializing BBC Radios Jun 23 20:53:06 ciucalumio systemd[1]: mpd.service: Succeeded. Jun 23 20:53:06 ciucalumio systemd[1]: Stopped Music Player Daemon. Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:06 ciucalumio volumio[798]: info: Creating Spotify config file Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:06 ciucalumio systemd[1]: Starting Music Player Daemon... Jun 23 20:53:06 ciucalumio volumio[798]: info: Loading i18n strings for locale it Jun 23 20:53:06 ciucalumio volumio[798]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jun 23 20:53:06 ciucalumio volumio[798]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jun 23 20:53:06 ciucalumio volumio[798]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:06 ciucalumio volumio[798]: info: FusionDsp - mixtype--------------------- None Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 23 20:53:06 ciucalumio volumio[798]: info: Loading i18n strings for locale it Jun 23 20:53:06 ciucalumio volumio[798]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jun 23 20:53:06 ciucalumio volumio[798]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jun 23 20:53:06 ciucalumio volumio[798]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:53:06 ciucalumio volumio[798]: info: Volumio Calling Home Jun 23 20:53:06 ciucalumio sudo[1192]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 23 20:53:06 ciucalumio sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio sudo[1192]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:06 ciucalumio volumio[798]: info: Preparing to generate the ALSA configuration file Jun 23 20:53:06 ciucalumio sudo[1199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jun 23 20:53:06 ciucalumio sudo[1199]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jun 23 20:53:06 ciucalumio sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jun 23 20:53:06 ciucalumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:06 ciucalumio volumio[798]: info: Discovery: adding ccbbc098-5bf0-4671-af0b-e991826e68f5 Jun 23 20:53:06 ciucalumio volumio[798]: info: Discovery: Found device CiuCaLumio Jun 23 20:53:06 ciucalumio volumio[798]: info: CoreCommandRouter::volumioGetState Jun 23 20:53:06 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:06 ciucalumio volumio[798]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 23 20:53:06 ciucalumio volumio[798]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jun 23 20:53:06 ciucalumio volumio[798]: info: Reading ALSA contributions from plugins. Jun 23 20:53:06 ciucalumio systemd[1]: Reloading. Jun 23 20:53:06 ciucalumio volumio[798]: info: touch_display: Backlight interface detected. Jun 23 20:53:06 ciucalumio volumio[798]: info: MPD Permissions set Jun 23 20:53:06 ciucalumio volumio[798]: info: MPD Permissions set Jun 23 20:53:07 ciucalumio volumio[798]: info: Spotify config file written Jun 23 20:53:07 ciucalumio sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 23 20:53:07 ciucalumio sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio volumio[798]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 23 20:53:07 ciucalumio volumio[798]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 23 20:53:07 ciucalumio volumio[798]: info: Volumio called home Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio 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. Jun 23 20:53:07 ciucalumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/rpi_backlight/brightness Jun 23 20:53:07 ciucalumio volumio[798]: info: touch_display: Raspberry Pi Foundation touch screen detected. Jun 23 20:53:07 ciucalumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio sudo[1232]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:07 ciucalumio sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jun 23 20:53:07 ciucalumio sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio volumio[798]: info: Starting Shairport Sync Jun 23 20:53:07 ciucalumio volumio[798]: info: Starting Shairport Sync Jun 23 20:53:07 ciucalumio sudo[1234]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:07 ciucalumio volumio[798]: info: Starting Shairport Sync Jun 23 20:53:07 ciucalumio sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:53:07 ciucalumio sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:53:07 ciucalumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:53:07 ciucalumio sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio volumio[798]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 23 20:53:07 ciucalumio volumio[798]: SPOTIFY: BQAYUTaOT6nHeJOW8j7LiOXBK6n5riJ0fLl-yqYBGJ_W4mkp1ACeYfAVgkT2NeIvULrqK-aFxmk5jYOkiGC5idqudHU-gF1_Wag5Xk9rzBR8SYehOZzFVOslFEPfxdVjy9BaE4bTB1PC65K2-s4FGACjt8jIV9GECIQYxcnYLFRz16Nsh38OgTQSgH7qsAY8XkYz94yLazuqvKvGdHWy1rSUhot8j6Ra5opqG1oJdwSdcWO_ka7Mss6fiD8oo4dbK1BSB-LIX8AqMwVpY6KDMsY Jun 23 20:53:07 ciucalumio volumio[798]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 23 20:53:07 ciucalumio volumio[798]: info: New Spotify access token = BQAYUTaOT6nHeJOW8j7LiOXBK6n5riJ0fLl-yqYBGJ_W4mkp1ACeYfAVgkT2NeIvULrqK-aFxmk5jYOkiGC5idqudHU-gF1_Wag5Xk9rzBR8SYehOZzFVOslFEPfxdVjy9BaE4bTB1PC65K2-s4FGACjt8jIV9GECIQYxcnYLFRz16Nsh38OgTQSgH7qsAY8XkYz94yLazuqvKvGdHWy1rSUhot8j6Ra5opqG1oJdwSdcWO_ka7Mss6fiD8oo4dbK1BSB-LIX8AqMwVpY6KDMsY Jun 23 20:53:07 ciucalumio volumio[798]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::volumioGetState Jun 23 20:53:07 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:07 ciucalumio volumio[798]: info: touch_display: File permissions for backlight brightness control set. Jun 23 20:53:07 ciucalumio volumio[798]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jun 23 20:53:07 ciucalumio volumio[798]: info: Asound.conf file unchanged, so no further update is needed Jun 23 20:53:07 ciucalumio volumio[798]: info: Output device has changed, restarting MPD Jun 23 20:53:07 ciucalumio sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:53:07 ciucalumio sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio sudo[1249]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:07 ciucalumio volumio[798]: info: Output device has changed, restarting Shairport Sync Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:07 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:07 ciucalumio sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:53:07 ciucalumio sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:07 ciucalumio volumio[798]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:53:07 ciucalumio volumio[798]: info: Preparing to generate the ALSA configuration file Jun 23 20:53:07 ciucalumio sudo[1205]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:07 ciucalumio sudo[1199]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:07 ciucalumio systemd[1]: Reloading. Jun 23 20:53:07 ciucalumio volumio[798]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 23 20:53:07 ciucalumio volumio[798]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jun 23 20:53:07 ciucalumio volumio[798]: info: Reading ALSA contributions from plugins. Jun 23 20:53:07 ciucalumio volumio[798]: info: MPD Permissions set Jun 23 20:53:07 ciucalumio volumio[798]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jun 23 20:53:07 ciucalumio volumio[798]: info: touch_display: systemctl daemon-reload succeeded. Jun 23 20:53:08 ciucalumio sudo[1258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jun 23 20:53:08 ciucalumio sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: Starting Shairport Sync Jun 23 20:53:08 ciucalumio volumio[798]: info: Asound.conf file unchanged, so no further update is needed Jun 23 20:53:08 ciucalumio volumio[798]: info: Output device has changed, restarting MPD Jun 23 20:53:08 ciucalumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:53:08 ciucalumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:08 ciucalumio volumio[798]: info: Output device has changed, restarting Shairport Sync Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:08 ciucalumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:53:08 ciucalumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:08 ciucalumio 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. Jun 23 20:53:08 ciucalumio sudo[1285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:53:08 ciucalumio sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:08 ciucalumio sudo[1282]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:08 ciucalumio volumio[798]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:53:08 ciucalumio volumio[798]: info: MPD Permissions set Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: Starting Shairport Sync Jun 23 20:53:08 ciucalumio volumio[798]: SPOTIFY: User informations: {"country":"IT","display_name":"cape_it","email":"a.capecchiacci@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/cape_it"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/cape_it","id":"cape_it","images":[],"product":"premium","type":"user","uri":"spotify:user:cape_it"} Jun 23 20:53:08 ciucalumio volumio[798]: info: Spotify Successfully logged in Jun 23 20:53:08 ciucalumio sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:53:08 ciucalumio sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:53:08 ciucalumio volumio[798]: info: [1750704788471] CoreMusicLibrary::Adding element Spotify Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:53:08 ciucalumio volumio[798]: Cannot find translation for source Spotify Jun 23 20:53:08 ciucalumio mpd[1197]: Jun 23 20:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 23 20:53:08 ciucalumio volumio[798]: info: camilladsp spawned new process with pid 1307, instance 1, run: true Jun 23 20:53:08 ciucalumio volumio[798]: info: camilladsp service started and running in background, instance 1 Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:53:08 ciucalumio volumio[798]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Jun 23 20:53:08 ciucalumio volumio[798]: info: FusionDsp loaded Jun 23 20:53:08 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 20:53:08 ciucalumio sudo[1201]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:08 ciucalumio sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 23 20:53:08 ciucalumio sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:08 ciucalumio volumio[798]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 23 20:53:08 ciucalumio volumio[798]: info: Adding Signal Path Element [object Object] Jun 23 20:53:08 ciucalumio volumio[798]: info: Adding fusiondspeq DSP Signal Path Element Jun 23 20:53:08 ciucalumio volumio[798]: info: FusionDsp - ---- installed callbackRead Jun 23 20:53:08 ciucalumio volumio[798]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jun 23 20:53:08 ciucalumio volumio[798]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:53:08 ciucalumio volumio[798]: error: FusionDsp - WebSocket error: [object Object] Jun 23 20:53:08 ciucalumio volumio[798]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 23 20:53:09 ciucalumio systemd[1]: Started FusionDsp Daemon. Jun 23 20:53:09 ciucalumio sudo[1324]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio systemd[1]: Started Volumio Kiosk. Jun 23 20:53:09 ciucalumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 23 20:53:09 ciucalumio sudo[1258]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio systemd[1]: Started go-librespot Daemon. Jun 23 20:53:09 ciucalumio sudo[1208]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 23 20:53:09 ciucalumio sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:09 ciucalumio go-librespot[1340]: Librespot-go daemon starting... Jun 23 20:53:09 ciucalumio sudo[1337]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio systemd[1]: shairport-sync.service: Succeeded. Jun 23 20:53:09 ciucalumio sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 23 20:53:09 ciucalumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 23 20:53:09 ciucalumio volumio[798]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jun 23 20:53:09 ciucalumio sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:09 ciucalumio volumio[798]: info: touch_display: Volumio Kiosk started. Jun 23 20:53:09 ciucalumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 23 20:53:09 ciucalumio systemd[1]: mpd.service: Succeeded. Jun 23 20:53:09 ciucalumio systemd[1]: Stopped Music Player Daemon. Jun 23 20:53:09 ciucalumio sudo[1346]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio volumio[798]: info: CoreCommandRouter::volumioGetState Jun 23 20:53:09 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:09 ciucalumio volumio[798]: info: CoreCommandRouter::volumioGetState Jun 23 20:53:09 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:09 ciucalumio systemd[1]: Starting Music Player Daemon... Jun 23 20:53:09 ciucalumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 23 20:53:09 ciucalumio sudo[1240]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio sudo[1238]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio sudo[1243]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 23 20:53:09 ciucalumio sudo[1280]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:09 ciucalumio sudo[1299]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio volumio[798]: info: Shairport-Sync Started Jun 23 20:53:09 ciucalumio volumio[798]: Error adding Membership: Error: addMembership EINVAL Jun 23 20:53:09 ciucalumio volumio[798]: info: Shairport-Sync Started Jun 23 20:53:09 ciucalumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 23 20:53:09 ciucalumio volumio[798]: info: touch_display: X display number found: 0 Jun 23 20:53:09 ciucalumio volumio[798]: info: Shairport-Sync Started Jun 23 20:53:09 ciucalumio volumio[798]: info: Shairport-Sync Started Jun 23 20:53:09 ciucalumio volumio[798]: info: Shairport-Sync Started Jun 23 20:53:09 ciucalumio sudo[1368]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio sudo[1358]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 23 20:53:09 ciucalumio sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:09 ciucalumio sudo[1358]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:09 ciucalumio volumio[798]: info: touch_display: X display number found: 0 Jun 23 20:53:09 ciucalumio volumio[798]: info: Upmpdcli Daemon Started Jun 23 20:53:09 ciucalumio volumio[798]: info: touch_display: X display number found: 0 Jun 23 20:53:09 ciucalumio startx[1336]: X.Org X Server 1.20.4 Jun 23 20:53:09 ciucalumio startx[1336]: X Protocol Version 11, Revision 0 Jun 23 20:53:09 ciucalumio startx[1336]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Jun 23 20:53:09 ciucalumio startx[1336]: Current Operating System: Linux ciucalumio 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l Jun 23 20:53:09 ciucalumio startx[1336]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=db7775c5-9234-4b9a-955e-7341a245d498 imgfile=/volumio_current.sqsh bootpart=UUID=F102-DE29 datapart=UUID=4112086d-38d3-4206-a7af-ef93bf4e4008 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Jun 23 20:53:09 ciucalumio startx[1336]: Build Date: 04 April 2023 07:50:56AM Jun 23 20:53:09 ciucalumio startx[1336]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Jun 23 20:53:09 ciucalumio startx[1336]: Current version of pixman: 0.36.0 Jun 23 20:53:09 ciucalumio startx[1336]: Before reporting problems, check http://wiki.x.org Jun 23 20:53:09 ciucalumio startx[1336]: to make sure that you have the latest version. Jun 23 20:53:09 ciucalumio startx[1336]: Markers: (--) probed, (**) from config file, (==) default setting, Jun 23 20:53:09 ciucalumio startx[1336]: (++) from command line, (!!) notice, (II) informational, Jun 23 20:53:09 ciucalumio startx[1336]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jun 23 20:53:09 ciucalumio startx[1336]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Jun 23 20:53:09 2025 Jun 23 20:53:09 ciucalumio startx[1336]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jun 23 20:53:09 ciucalumio startx[1336]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jun 23 20:53:09 ciucalumio volumio[798]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jun 23 20:53:09 ciucalumio volumio[798]: info: touch_display: X display number found: 0 Jun 23 20:53:09 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:09+02:00" level=info msg="generated new device id: 6154f9a4cc3be276359ce6315e3cf9afeb2dc5f7" Jun 23 20:53:09 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:09+02:00" level=debug msg="stored credentials found for cape_it" Jun 23 20:53:10 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:10+02:00" level=debug msg="obtained new client token: AABXu7uq46eDo1TWS4nOycb0OSJpHPZjMU6pugUpRfjJx8jOyO7MOFz3sAJTuxSXgY3TdI/yMYlY4OgMmjUAYNJ59GC5QfjLi9OHTTkWxJ9pFsl1qG+YK3C4PpUIbbVO1a40NSq1IXTntHGn0GENgahbcnVQR2D8rM0sqljm4GsUwkg5ma9oDiHjeZtc9eFxZ2ndadSjMJCHkbuYr8M4idA5CtqqWF/jsNQdbDHnRGCIyueDALwphAIguq4RkPeS" Jun 23 20:53:10 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:10+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Jun 23 20:53:10 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:10+02:00" level=debug msg="completed keyexchange" Jun 23 20:53:10 ciucalumio mpd[1385]: Jun 23 20:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="completed challenge" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="authenticated as cape_it" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="authenticated as cape_it" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="dealer connection opened" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="received connection id: ZDE4YTlkMDYtMDdlZC00MTkzLTlkNDMtZWFiYjcyMjViYjJhK2RlYWxlcit0Y3A6Ly8wYWNhNThlNC5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArNThGN0YyQkY0QzJDQjVEN0M4QzhCQzE2Q0Q5NDQzNTA4QTlENzc2ODkwRUU3NDY4REJDQzJBRDlEODYxNzJGOQ==" Jun 23 20:53:11 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:11+02:00" level=debug msg="put connect state because NEW_DEVICE" Jun 23 20:53:11 ciucalumio systemd[1]: Started Music Player Daemon. Jun 23 20:53:11 ciucalumio volumio[798]: Upnp client error: Error: This socket has been ended by the other party Jun 23 20:53:11 ciucalumio sudo[1173]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:11 ciucalumio sudo[1285]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:11 ciucalumio sudo[1164]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:11 ciucalumio sudo[1252]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:11 ciucalumio volumio[798]: info: Completed starting Core Plugins Jun 23 20:53:11 ciucalumio volumio[798]: info: ------------------------------------------- Jun 23 20:53:11 ciucalumio volumio[798]: info: ----- MyVolumio plugins startup ---- Jun 23 20:53:11 ciucalumio volumio[798]: info: ------------------------------------------- Jun 23 20:53:11 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 23 20:53:11 ciucalumio volumio[798]: info: MPD running with PID1385 Jun 23 20:53:11 ciucalumio volumio[798]: ,establishing connection Jun 23 20:53:12 ciucalumio volumio[798]: error: MPD error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: MPD error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: MPD error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: MPD error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: The expression evaluated to a falsy value: Jun 23 20:53:12 ciucalumio volumio[798]: assert.ok(self.idling) Jun 23 20:53:12 ciucalumio volumio[798]: error: updateQueue error: null Jun 23 20:53:12 ciucalumio volumio[798]: info: go-librespot daemon successfully initialized Jun 23 20:53:12 ciucalumio startx[1336]: [1B blob data] Jun 23 20:53:12 ciucalumio volumio[798]: info: CoreCommandRouter::volumioGetState Jun 23 20:53:12 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:13 ciucalumio volumio[798]: info: touch_display: Setting screensaver timeout to 120 seconds. Jun 23 20:53:13 ciucalumio volumio[1377]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 23 20:53:13 ciucalumio startx[1336]: waiting for X server to begin accepting connections . Jun 23 20:53:14 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:14] [connect] Successful connection Jun 23 20:53:14 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750704794 101 Jun 23 20:53:14 ciucalumio volumio[798]: 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: 5 Jun 23 20:53:15 ciucalumio volumio[798]: info: Initializing connection to go-librespot Websocket Jun 23 20:53:15 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:15+02:00" level=debug msg="new websocket client" Jun 23 20:53:15 ciucalumio volumio[798]: info: Connection to go-librespot Websocket established Jun 23 20:53:15 ciucalumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 23 20:53:18 ciucalumio volumio[798]: info: Getting Spotify volume Jun 23 20:53:18 ciucalumio volumio[798]: info: Spotify volume: 100 Jun 23 20:53:18 ciucalumio volumio[798]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 23 20:53:18 ciucalumio volumio[798]: info: CoreCommandRouter::volumioGetState Jun 23 20:53:18 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:18 ciucalumio systemd[1]: systemd-hostnamed.service: Succeeded. Jun 23 20:53:18 ciucalumio volumio[798]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 23 20:53:22 ciucalumio volumio[798]: info: Adding plugin bluetooth to MyMusic Plugins Jun 23 20:53:22 ciucalumio volumio[798]: info: Adding plugin multiroom to MyMusic Plugins Jun 23 20:53:22 ciucalumio volumio[798]: info: Adding plugin metavolumio to MyMusic Plugins Jun 23 20:53:22 ciucalumio volumio[798]: info: Adding plugin cd_controller to MyMusic Plugins Jun 23 20:53:22 ciucalumio volumio[798]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 23 20:53:22 ciucalumio volumio[798]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 23 20:53:22 ciucalumio volumio[798]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 23 20:53:22 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 23 20:53:23 ciucalumio systemd[1]: systemd-timedated.service: Succeeded. Jun 23 20:53:26 ciucalumio volumio[798]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 23 20:53:26 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 23 20:53:26 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:26 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:26 ciucalumio volumio[798]: info: Starting MyVolumio Remote Streaming Endpoints Jun 23 20:53:26 ciucalumio volumio[798]: info: MyVolumio login type: Token Jun 23 20:53:26 ciucalumio volumio[798]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 23 20:53:26 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 23 20:53:28 ciucalumio volumio[798]: info: Starting Streaming Service Transparent Proxy Jun 23 20:53:28 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 23 20:53:28 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 23 20:53:28 ciucalumio volumio[798]: info: Streaming services startup Jun 23 20:53:28 ciucalumio volumio[798]: info: Starting Streaming Daemon Jun 23 20:53:28 ciucalumio volumio[798]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 23 20:53:28 ciucalumio sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 23 20:53:28 ciucalumio sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:28 ciucalumio sudo[1650]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:29 ciucalumio volumio[798]: error: Cannot start Volumio Streaming Daemon Jun 23 20:53:29 ciucalumio volumio[798]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 23 20:53:29 ciucalumio volumio[798]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 23 20:53:30 ciucalumio volumio[798]: error: MyVolumio Custom Token format not valid, refreshing it Jun 23 20:53:30 ciucalumio volumio[1377]: ................................................................................................................................................++++ Jun 23 20:53:30 ciucalumio volumio[798]: STREAMING PROXY: Starting server on port 3245 Jun 23 20:53:30 ciucalumio volumio[798]: Node JS runtime: 14 Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="handling transfer player command from e0dac72d7b2c7799460445bb163e059dfcc5c5b6" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=trace msg="fetched new page 0 with 20 items (list: 20)" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="loading track spotify:track:72d38PCaL34IJULbV7rZ0o (paused: true, position: 4923ms)" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=trace msg="emitting websocket event: will_play" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:72d38PCaL34IJULbV7rZ0o" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="requested aes key for file 6a72561d9643d93c9b981cdf87bd5119d1999977, gid: 72d38PCaL34IJULbV7rZ0o" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1331" Jun 23 20:53:33 ciucalumio volumio[798]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","play_origin":"playlist"}} Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1111" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="fetched first chunk of 20, total size is 10208316 bytes" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=trace msg="seek to 4923ms (diff: 139ms, samples: 217104, bytes: 176465)" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="fetched chunk 3/19, size: 524288" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="fetched chunk 2/19, size: 524288" Jun 23 20:53:33 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:33+02:00" level=debug msg="fetched chunk 1/19, size: 524288" Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=info msg="loaded track \"Digging Your Scene\" (uri: spotify:track:72d38PCaL34IJULbV7rZ0o, paused: true, position: 4923ms, duration: 254266ms)" Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=trace msg="emitting websocket event: metadata" Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=trace msg="emitting websocket event: active" Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=debug msg="sending successful reply for delaer request" Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:53:34 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:34+02:00" level=trace msg="emitting websocket event: paused" Jun 23 20:53:34 ciucalumio volumio[798]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 23 20:53:34 ciucalumio volumio[798]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 23 20:53:34 ciucalumio volumio[798]: info: camilladsp stopping service pid 1307... Jun 23 20:53:34 ciucalumio volumio[798]: info: camilladsp service terminated, instance 1 Jun 23 20:53:34 ciucalumio volumio[798]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:53:34 ciucalumio volumio[798]: info: camilladsp service started and running in background, instance 1 Jun 23 20:53:34 ciucalumio volumio[798]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","name":"Digging Your Scene","artist_names":["The Blow Monkeys"],"album_name":"Animal Magic (Expanded Edition)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e027a5445556637a40162b128e9","position":4923,"duration":254266,"release_date":"year:1986","track_number":1,"disc_number":1}} Jun 23 20:53:34 ciucalumio volumio[798]: SPOTIFY: received: {"type":"active","data":null} Jun 23 20:53:34 ciucalumio volumio[798]: info: Aligning Spotify Volume to Volumio Volume Jun 23 20:53:34 ciucalumio volumio[798]: info: CoreCommandRouter::volumioGetState Jun 23 20:53:34 ciucalumio volumio[798]: info: CorePlayQueue::getTrack 0 Jun 23 20:53:34 ciucalumio volumio[798]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","play_origin":"playlist"}} Jun 23 20:53:34 ciucalumio volumio[798]: info: Spotify is playing in volatile mode Jun 23 20:53:34 ciucalumio volumio[798]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 23 20:53:34 ciucalumio volumio[798]: SPOTIFY: UNSET VOLATILE Jun 23 20:53:34 ciucalumio volumio[798]: SPOTIFY: {"status":"stop","position":0,"title":"Once","artist":"Pearl Jam","album":"Ten","albumart":"/albumart?cacheid=119&web=Pearl%20Jam/Ten/extralarge&path=%2FNAS%2FMusic_FLAC%2FPearl%20Jam%2FTen&metadata=false","uri":"mnt/NAS/Music_FLAC/Pearl Jam/Ten/01 - Once.flac","trackType":"flac","seek":0,"duration":232,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":true,"mute":false,"stream":"flac","updatedb":false,"volatile":false,"service":"mpd"} Jun 23 20:53:34 ciucalumio volumio[798]: SPOTIFY: PUSH STATE SPOTIFY Jun 23 20:53:34 ciucalumio volumio[798]: SPOTIFY: {"status":"pause","service":"spop","title":"Digging Your Scene","artist":"The Blow Monkeys","album":"Animal Magic (Expanded Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e027a5445556637a40162b128e9","uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","trackType":"spotify","seek":4923,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jun 23 20:53:34 ciucalumio volumio[798]: info: CoreCommandRouter::servicePushState Jun 23 20:53:34 ciucalumio volumio[798]: info: CoreStateMachine::pushState Jun 23 20:53:34 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 20:53:34 ciucalumio volumio[798]: info: CoreCommandRouter::volumioPushState Jun 23 20:53:34 ciucalumio volumio[798]: info: camilladsp spawned new process with pid 1679, instance 1, run: true Jun 23 20:53:35 ciucalumio volumio[798]: info: PeppyMeterBasic ---peppymeterbasic status pause Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="handling play player command from e0dac72d7b2c7799460445bb163e059dfcc5c5b6" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=trace msg="fetched new page 0 with 20 items (list: 20)" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="loading track spotify:track:72d38PCaL34IJULbV7rZ0o (paused: false, position: 0ms)" Jun 23 20:53:35 ciucalumio sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 23 20:53:35 ciucalumio sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=trace msg="emitting websocket event: will_play" Jun 23 20:53:35 ciucalumio sudo[1688]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:72d38PCaL34IJULbV7rZ0o" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="requested aes key for file 6a72561d9643d93c9b981cdf87bd5119d1999977, gid: 72d38PCaL34IJULbV7rZ0o" Jun 23 20:53:35 ciucalumio volumio[798]: info: MyVolumio login type: Token Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="fetched first chunk of 20, total size is 10208316 bytes" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=info msg="loaded track \"Digging Your Scene\" (uri: spotify:track:72d38PCaL34IJULbV7rZ0o, paused: false, position: 0ms, duration: 254266ms)" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=trace msg="emitting websocket event: metadata" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="sending successful reply for delaer request" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="fetched chunk 3/19, size: 524288" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=trace msg="emitting websocket event: playing" Jun 23 20:53:35 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:35+02:00" level=debug msg="fetched chunk 2/19, size: 524288" Jun 23 20:53:36 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:36+02:00" level=debug msg="fetched chunk 1/19, size: 524288" Jun 23 20:53:36 ciucalumio volumio[798]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","play_origin":"playlist"}} Jun 23 20:53:36 ciucalumio volumio[798]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","name":"Digging Your Scene","artist_names":["The Blow Monkeys"],"album_name":"Animal Magic (Expanded Edition)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e027a5445556637a40162b128e9","position":0,"duration":254266,"release_date":"year:1986","track_number":1,"disc_number":1}} Jun 23 20:53:36 ciucalumio volumio[798]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","play_origin":"playlist"}} Jun 23 20:53:36 ciucalumio volumio[798]: SPOTIFY: PUSH STATE SPOTIFY Jun 23 20:53:36 ciucalumio volumio[798]: SPOTIFY: {"status":"play","service":"spop","title":"Digging Your Scene","artist":"The Blow Monkeys","album":"Animal Magic (Expanded Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e027a5445556637a40162b128e9","uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::servicePushState Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreStateMachine::pushState Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::volumioPushState Jun 23 20:53:36 ciucalumio volumio[798]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 23 20:53:36 ciucalumio volumio[798]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 23 20:53:36 ciucalumio volumio[798]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:53:36 ciucalumio volumio[798]: info: peppymeterbasic Daemon Stop Jun 23 20:53:36 ciucalumio volumio[798]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 23 20:53:36 ciucalumio volumio[798]: SPOTIFY: PUSH STATE SPOTIFY Jun 23 20:53:36 ciucalumio volumio[798]: SPOTIFY: {"status":"play","service":"spop","title":"Digging Your Scene","artist":"The Blow Monkeys","album":"Animal Magic (Expanded Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e027a5445556637a40162b128e9","uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::servicePushState Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreStateMachine::pushState Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::volumioPushState Jun 23 20:53:36 ciucalumio sudo[1695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 23 20:53:36 ciucalumio sudo[1695]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:53:36 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 23 20:53:37 ciucalumio systemd[1]: Started peppymeterbasic Daemon. Jun 23 20:53:37 ciucalumio sudo[1695]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:37 ciucalumio volumio[798]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 23 20:53:37 ciucalumio sudo[1702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 23 20:53:37 ciucalumio sudo[1702]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:37 ciucalumio sudo[1702]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:38 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 23 20:53:38 ciucalumio volumio[798]: info: peppymeterbasic Daemon Started Jun 23 20:53:38 ciucalumio volumio-remote-updater[618]: No test mode Jun 23 20:53:38 ciucalumio volumio-remote-updater[618]: No alpha test mode Jun 23 20:53:38 ciucalumio volumio[798]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 23 20:53:38 ciucalumio volumio[798]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 23 20:53:38 ciucalumio volumio[798]: info: peppymeterbasic Daemon Started Jun 23 20:53:39 ciucalumio volumio[798]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 23 20:53:40 ciucalumio volumio[798]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 23 20:53:40 ciucalumio volumio[798]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 23 20:53:42 ciucalumio volumio[1699]: libpng warning: iCCP: known incorrect sRGB profile Jun 23 20:53:42 ciucalumio volumio[1699]: libpng warning: iCCP: known incorrect sRGB profile Jun 23 20:53:42 ciucalumio volumio[1699]: libpng warning: iCCP: known incorrect sRGB profile Jun 23 20:53:43 ciucalumio volumio[798]: <--- Last few GCs ---> Jun 23 20:53:43 ciucalumio volumio[798]: [798:0x4639780] 52825 ms: Scavenge 163.6 (174.5) -> 163.5 (174.5) MB, 1.1 / 0.0 ms (average mu = 0.910, current mu = 0.921) allocation failure Jun 23 20:53:43 ciucalumio volumio[798]: [798:0x4639780] 52936 ms: Scavenge 185.3 (196.2) -> 185.2 (196.2) MB, 0.9 / 0.0 ms (average mu = 0.910, current mu = 0.921) allocation failure Jun 23 20:53:43 ciucalumio volumio[798]: <--- JS stacktrace ---> Jun 23 20:53:43 ciucalumio volumio[798]: FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory Jun 23 20:53:43 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:43+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Jun 23 20:53:43 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:43] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 23 20:53:43 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:43] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 23 20:53:43 ciucalumio volumio[1377]: ..........................................................................................................++++ Jun 23 20:53:43 ciucalumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Jun 23 20:53:43 ciucalumio systemd[1]: volumio.service: Failed with result 'signal'. Jun 23 20:53:44 ciucalumio systemd[1]: Started dynamicswap service. Jun 23 20:53:44 ciucalumio volumio[1377]: e is 65537 (0x010001) Jun 23 20:53:44 ciucalumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 23 20:53:44 ciucalumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jun 23 20:53:44 ciucalumio systemd[1]: Stopped Volumio Backend Module. Jun 23 20:53:44 ciucalumio volumio[1377]: writing RSA key Jun 23 20:53:44 ciucalumio systemd[1]: Started Volumio Backend Module. Jun 23 20:53:44 ciucalumio systemd[1]: dynamicswap.service: Succeeded. Jun 23 20:53:48 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:48] [info] asio async_connect error: system:111 (Connection refused) Jun 23 20:53:48 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 23 20:53:48 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:48] [error] handle_connect error: Underlying Transport Error Jun 23 20:53:50 ciucalumio volumio[1731]: info: ------------------------------------------- Jun 23 20:53:50 ciucalumio volumio[1731]: info: ----- Volumio3 ---- Jun 23 20:53:50 ciucalumio volumio[1731]: info: ------------------------------------------- Jun 23 20:53:50 ciucalumio volumio[1731]: info: ----- System startup ---- Jun 23 20:53:50 ciucalumio volumio[1731]: info: ------------------------------------------- Jun 23 20:53:51 ciucalumio go-librespot[1340]: time="2025-06-23T20:53:51+02:00" level=debug msg="handling skip_prev player command from e0dac72d7b2c7799460445bb163e059dfcc5c5b6" Jun 23 20:53:51 ciucalumio volumio[1731]: info: MYVOLUMIO Environment detected Jun 23 20:53:51 ciucalumio volumio[1731]: info: Plugin folders cleanup Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning into folder /volumio/app/plugins/ Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category audio_interface Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category miscellanea Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category music_service Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category plugins.json Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category system_controller Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category user_interface Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning into folder /data/plugins/ Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category audio_interface Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category music_service Jun 23 20:53:51 ciucalumio volumio[1731]: info: Scanning category user_interface Jun 23 20:53:51 ciucalumio volumio[1731]: info: Plugin folders cleanup completed Jun 23 20:53:51 ciucalumio volumio[1731]: info: ------------------------------------------- Jun 23 20:53:51 ciucalumio volumio[1731]: info: ----- Core plugins startup ---- Jun 23 20:53:51 ciucalumio volumio[1731]: info: ------------------------------------------- Jun 23 20:53:51 ciucalumio volumio[1731]: info: Loading plugins from folder /volumio/app/plugins/ Jun 23 20:53:51 ciucalumio volumio[1731]: info: Adding plugin upnp to MyMusic Plugins Jun 23 20:53:51 ciucalumio volumio[1731]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 23 20:53:51 ciucalumio volumio[1731]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 23 20:53:51 ciucalumio volumio[1731]: info: Loading plugins from folder /data/plugins/ Jun 23 20:53:51 ciucalumio volumio[1731]: info: Loading plugin "system"... Jun 23 20:53:51 ciucalumio volumio[1731]: info: Loading plugin "appearance"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "network"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: Refreshing Cached IP Addresses Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "services"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "alsa_controller"... Jun 23 20:53:53 ciucalumio sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 23 20:53:53 ciucalumio sudo[2024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 23 20:53:53 ciucalumio sudo[2024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:53 ciucalumio sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:53:53 ciucalumio sudo[2024]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:53 ciucalumio sudo[2022]: pam_unix(sudo:session): session closed for user root Jun 23 20:53:53 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "wizard"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "networkfs"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: Cannot mount NAS Music_FLAC at system boot, trial number 1 ,retrying in 5 seconds Jun 23 20:53:53 ciucalumio volumio[1731]: info: Cannot mount NAS Music_Mp3 at system boot, trial number 1 ,retrying in 5 seconds Jun 23 20:53:53 ciucalumio volumio[1731]: info: Cannot mount NAS Music_DSD at system boot, trial number 1 ,retrying in 5 seconds Jun 23 20:53:53 ciucalumio volumio[1731]: info: Starting Udev Watcher for removable devices Jun 23 20:53:53 ciucalumio volumio[1731]: info: Ignoring mount for partition: boot Jun 23 20:53:53 ciucalumio volumio[1731]: info: Ignoring mount for partition: volumio Jun 23 20:53:53 ciucalumio volumio[1731]: info: Ignoring mount for partition: volumio_data Jun 23 20:53:53 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "volumio_command_line_client"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "upnp"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: [1750704833794] Starting Upmpd Daemon Jun 23 20:53:53 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "my_music"... Jun 23 20:53:53 ciucalumio volumio[1731]: info: Loading plugin "mpd"... Jun 23 20:53:54 ciucalumio volumio[1731]: info: Loading plugin "upnp_browser"... Jun 23 20:53:54 ciucalumio volumio[1731]: info: Loading plugin "alarm-clock"... Jun 23 20:53:54 ciucalumio volumio[1731]: info: Loading plugin "airplay_emulation"... Jun 23 20:53:54 ciucalumio volumio[1731]: info: Starting Shairport Sync Jun 23 20:53:54 ciucalumio volumio[1731]: info: Loading plugin "last_100"... Jun 23 20:53:54 ciucalumio volumio[1731]: info: Loading plugin "webradio"... Jun 23 20:53:55 ciucalumio volumio[1731]: info: Loading plugin "i2s_dacs"... Jun 23 20:53:55 ciucalumio volumio[1731]: info: I2S DAC not set, start Auto-detection Jun 23 20:53:55 ciucalumio volumio[1731]: info: Loading plugin "volumiodiscovery"... Jun 23 20:53:55 ciucalumio volumio[1731]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 23 20:53:55 ciucalumio volumio[1731]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 20:53:55 ciucalumio volumio[1731]: *** WARNING *** For more information see Jun 23 20:53:55 ciucalumio node[1731]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 23 20:53:55 ciucalumio volumio[1731]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 23 20:53:55 ciucalumio volumio[1731]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 20:53:55 ciucalumio volumio[1731]: *** WARNING *** For more information see Jun 23 20:53:55 ciucalumio node[1731]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 20:53:55 ciucalumio node[1731]: *** WARNING *** For more information see Jun 23 20:53:55 ciucalumio node[1731]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 23 20:53:55 ciucalumio node[1731]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 23 20:53:55 ciucalumio node[1731]: *** WARNING *** For more information see Jun 23 20:53:55 ciucalumio volumio[1731]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 23 20:53:55 ciucalumio volumio[1731]: info: Discovery: Started advertising with name: CiuCaLumio Jun 23 20:53:55 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 23 20:53:55 ciucalumio volumio[1731]: info: Loading plugin "spop"... Jun 23 20:53:56 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:53:56] [connect] Successful connection Jun 23 20:53:59 ciucalumio volumio[1731]: info: Loading plugin "outputs"... Jun 23 20:53:59 ciucalumio volumio[1731]: info: Loading plugin "albumart"... Jun 23 20:53:59 ciucalumio volumio[1731]: info: Plugin example_plugin is not enabled Jun 23 20:53:59 ciucalumio volumio[1731]: info: Loading plugin "inputs"... Jun 23 20:53:59 ciucalumio volumio[1731]: info: Loading plugin "updater_comm"... Jun 23 20:53:59 ciucalumio volumio[1731]: info: Plugin mpdemulation is not enabled Jun 23 20:53:59 ciucalumio volumio[1731]: info: Loading plugin "rest_api"... Jun 23 20:53:59 ciucalumio volumio[1731]: info: Loading plugin "websocket"... Jun 23 20:53:59 ciucalumio volumio[1731]: info: Starting Socket.io Server version 2.3.0 Jun 23 20:53:59 ciucalumio volumio[1731]: info: Loading plugin "fusiondsp"... Jun 23 20:53:59 ciucalumio volumio[1731]: Forking 3 albumart workers Jun 23 20:54:00 ciucalumio volumio[1731]: info: Applying required configuration parameters for plugin fusiondsp Jun 23 20:54:00 ciucalumio volumio[1731]: info: Loading plugin "Systeminfo"... Jun 23 20:54:00 ciucalumio volumio[1731]: Starting albumart workers Jun 23 20:54:00 ciucalumio volumio[1731]: Starting albumart workers Jun 23 20:54:00 ciucalumio volumio[1731]: Starting albumart workers Jun 23 20:54:01 ciucalumio volumio[1731]: info: Loading plugin "peppymeterbasic"... Jun 23 20:54:01 ciucalumio volumio[1731]: info: Loading plugin "touch_display"... Jun 23 20:54:02 ciucalumio volumio[1731]: info: Applying required configuration parameters for plugin touch_display Jun 23 20:54:02 ciucalumio volumio[1731]: info: Loading i18n strings for locale it Jun 23 20:54:02 ciucalumio volumio[1731]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jun 23 20:54:02 ciucalumio volumio[1731]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jun 23 20:54:02 ciucalumio volumio[1731]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 23 20:54:02 ciucalumio volumio[1731]: Updating browse sources language Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::initPlayerControls Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: Express server listening on port 3000 Jun 23 20:54:02 ciucalumio volumio[1731]: [Metrics] WebUI: 13s 268.52ms Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreStateMachine::resetVolumioState Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreStateMachine::getcurrentVolume Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioRetrievevolume Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreStateMachine::pushState Jun 23 20:54:02 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioPushState Jun 23 20:54:02 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:02 ciucalumio volumio[1731]: info: Cannot mount NAS Music_FLAC at system boot, trial number 2 ,retrying in 5 seconds Jun 23 20:54:02 ciucalumio volumio[1731]: info: Cannot mount NAS Music_Mp3 at system boot, trial number 2 ,retrying in 5 seconds Jun 23 20:54:02 ciucalumio volumio[1731]: info: Cannot mount NAS Music_DSD at system boot, trial number 2 ,retrying in 5 seconds Jun 23 20:54:02 ciucalumio volumio[1731]: info: Volumio Network Manager: Network status updated: 1 Jun 23 20:54:03 ciucalumio volumio[1731]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 23 20:54:03 ciucalumio volumio[1731]: info: Reloading queue from file Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreStateMachine::setRepeat null single undefined Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreStateMachine::pushState Jun 23 20:54:03 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioPushState Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreStateMachine::setRandom null Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreStateMachine::pushState Jun 23 20:54:03 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioPushState Jun 23 20:54:03 ciucalumio volumio[1731]: info: Setting Device type: Raspberry PI Jun 23 20:54:03 ciucalumio volumio[1731]: info: Discovery: adding ccbbc098-5bf0-4671-af0b-e991826e68f5 Jun 23 20:54:03 ciucalumio volumio[1731]: info: Discovery: Found device CiuCaLumio Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioGetState Jun 23 20:54:03 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:03 ciucalumio volumio[1731]: info: Completed loading Core Plugins Jun 23 20:54:03 ciucalumio volumio[1731]: info: Preparing to generate the ALSA configuration file Jun 23 20:54:03 ciucalumio volumio[1731]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 23 20:54:03 ciucalumio volumio[1731]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jun 23 20:54:03 ciucalumio volumio[1731]: info: Reading ALSA contributions from plugins. Jun 23 20:54:03 ciucalumio volumio[1731]: info: Asound.conf file unchanged, so no further update is needed Jun 23 20:54:03 ciucalumio volumio[1731]: info: Output device has changed, restarting MPD Jun 23 20:54:03 ciucalumio volumio[1731]: info: Output device has changed, restarting Shairport Sync Jun 23 20:54:03 ciucalumio sudo[2107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:54:03 ciucalumio sudo[2107]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:03 ciucalumio sudo[2107]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:03 ciucalumio sudo[2109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:54:03 ciucalumio sudo[2109]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:03 ciucalumio volumio[1731]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:54:03 ciucalumio volumio[1731]: info: ___________ START PLUGINS ___________ Jun 23 20:54:03 ciucalumio volumio[1731]: info: ControllerMpd::onStart: Initializing MPD Jun 23 20:54:03 ciucalumio volumio[1731]: info: Creating MPD Configuration file Jun 23 20:54:03 ciucalumio systemd[1]: Stopping Music Player Daemon... Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:54:03 ciucalumio volumio[1731]: info: [1750704843386] CoreMusicLibrary::Adding element Server multimediali Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:54:03 ciucalumio sudo[2116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:54:03 ciucalumio sudo[2116]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:03 ciucalumio sudo[2116]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:03 ciucalumio sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:03 ciucalumio sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:03 ciucalumio volumio[1731]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:54:03 ciucalumio volumio[1731]: info: [1750704843530] CoreMusicLibrary::Adding element Last_100 Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:54:03 ciucalumio volumio[1731]: info: [1750704843535] CoreMusicLibrary::Adding element Webradio Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:54:03 ciucalumio volumio[1731]: info: Initializing BBC Radios Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: Creating Spotify config file Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: Loading i18n strings for locale it Jun 23 20:54:03 ciucalumio volumio[1731]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jun 23 20:54:03 ciucalumio volumio[1731]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jun 23 20:54:03 ciucalumio volumio[1731]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:03 ciucalumio volumio[1731]: info: FusionDsp - mixtype--------------------- None Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 23 20:54:03 ciucalumio volumio[1731]: info: Loading i18n strings for locale it Jun 23 20:54:03 ciucalumio volumio[1731]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jun 23 20:54:03 ciucalumio volumio[1731]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jun 23 20:54:03 ciucalumio volumio[1731]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 23 20:54:03 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 23 20:54:03 ciucalumio volumio[1731]: info: Volumio Calling Home Jun 23 20:54:03 ciucalumio volumio[1731]: info: Preparing to generate the ALSA configuration file Jun 23 20:54:04 ciucalumio volumio[1731]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 23 20:54:04 ciucalumio volumio[1731]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jun 23 20:54:04 ciucalumio volumio[1731]: info: Reading ALSA contributions from plugins. Jun 23 20:54:04 ciucalumio volumio[1731]: info: touch_display: Backlight interface detected. Jun 23 20:54:04 ciucalumio volumio[1731]: info: MPD Permissions set Jun 23 20:54:04 ciucalumio volumio[1731]: info: MPD Permissions set Jun 23 20:54:04 ciucalumio volumio[1731]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 23 20:54:04 ciucalumio volumio[1731]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 23 20:54:04 ciucalumio sudo[2162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 23 20:54:04 ciucalumio sudo[2162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jun 23 20:54:04 ciucalumio sudo[2154]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jun 23 20:54:04 ciucalumio sudo[2162]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:04 ciucalumio sudo[2156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jun 23 20:54:04 ciucalumio sudo[2160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 23 20:54:04 ciucalumio sudo[2156]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2160]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2160]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:04 ciucalumio volumio[1731]: info: Spotify config file written Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio sudo[2170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 23 20:54:04 ciucalumio sudo[2170]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioGetState Jun 23 20:54:04 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:04 ciucalumio volumio[1731]: info: Volumio called home Jun 23 20:54:04 ciucalumio sudo[2181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/rpi_backlight/brightness Jun 23 20:54:04 ciucalumio sudo[2181]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2181]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:04 ciucalumio volumio[1731]: info: touch_display: Raspberry Pi Foundation touch screen detected. Jun 23 20:54:04 ciucalumio systemd[1]: Reloading. Jun 23 20:54:04 ciucalumio sudo[2184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jun 23 20:54:04 ciucalumio sudo[2184]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio volumio[1731]: info: Starting Shairport Sync Jun 23 20:54:04 ciucalumio sudo[2184]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:04 ciucalumio volumio[1731]: info: Starting Shairport Sync Jun 23 20:54:04 ciucalumio sudo[2187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:54:04 ciucalumio sudo[2187]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 23 20:54:04 ciucalumio sudo[2189]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio volumio[1731]: info: Starting Shairport Sync Jun 23 20:54:04 ciucalumio sudo[2192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:54:04 ciucalumio sudo[2192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:54:04 ciucalumio sudo[2196]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio volumio[1731]: info: touch_display: File permissions for backlight brightness control set. Jun 23 20:54:04 ciucalumio volumio[1731]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jun 23 20:54:04 ciucalumio volumio[1731]: info: Asound.conf file unchanged, so no further update is needed Jun 23 20:54:04 ciucalumio volumio[1731]: info: Output device has changed, restarting MPD Jun 23 20:54:04 ciucalumio volumio[1731]: info: Output device has changed, restarting Shairport Sync Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:04 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:04 ciucalumio sudo[2213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:54:04 ciucalumio sudo[2213]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio sudo[2213]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:04 ciucalumio sudo[2215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:54:04 ciucalumio sudo[2215]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:04 ciucalumio volumio[1731]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:54:04 ciucalumio volumio[1731]: info: Preparing to generate the ALSA configuration file Jun 23 20:54:04 ciucalumio volumio[1731]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 23 20:54:04 ciucalumio volumio[1731]: SPOTIFY: BQBwa6Xf6kho1EzRqM7LJNiIQyPZ-duSxnSDHkXBQ9zrLi76nhrNYUIwo9Rr7wDWEr-Ls9za-fP2gztXxoRbdwfNyN4kZA092MBC9tVjRrWntRb-R-89pAVB7jXoIGmP5GUmfTFGjuFX4xPIcdla4VLeZwWWk31xww0_oLYhDilZElnTtk73BH2BiHfrqSLuB0p6QpGcXtKLlT3AokuYU5mMgrM9-uU644kgasyDhNc5qxMJLOeY9qWmRvbu4OzIraiAhDHvReqbDK-tkGqZsms Jun 23 20:54:04 ciucalumio volumio[1731]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 23 20:54:04 ciucalumio volumio[1731]: info: New Spotify access token = BQBwa6Xf6kho1EzRqM7LJNiIQyPZ-duSxnSDHkXBQ9zrLi76nhrNYUIwo9Rr7wDWEr-Ls9za-fP2gztXxoRbdwfNyN4kZA092MBC9tVjRrWntRb-R-89pAVB7jXoIGmP5GUmfTFGjuFX4xPIcdla4VLeZwWWk31xww0_oLYhDilZElnTtk73BH2BiHfrqSLuB0p6QpGcXtKLlT3AokuYU5mMgrM9-uU644kgasyDhNc5qxMJLOeY9qWmRvbu4OzIraiAhDHvReqbDK-tkGqZsms Jun 23 20:54:04 ciucalumio volumio[1731]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 23 20:54:05 ciucalumio volumio[1731]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 23 20:54:05 ciucalumio volumio[1731]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jun 23 20:54:05 ciucalumio volumio[1731]: info: Reading ALSA contributions from plugins. Jun 23 20:54:05 ciucalumio volumio[1731]: info: MPD Permissions set Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: Starting Shairport Sync Jun 23 20:54:05 ciucalumio volumio[1731]: info: Asound.conf file unchanged, so no further update is needed Jun 23 20:54:05 ciucalumio volumio[1731]: info: Output device has changed, restarting MPD Jun 23 20:54:05 ciucalumio sudo[2228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:54:05 ciucalumio sudo[2228]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:05 ciucalumio volumio[1731]: info: Output device has changed, restarting Shairport Sync Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:05 ciucalumio sudo[2230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 23 20:54:05 ciucalumio sudo[2230]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:05 ciucalumio sudo[2230]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:05 ciucalumio sudo[2233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 23 20:54:05 ciucalumio sudo[2233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:05 ciucalumio volumio[1731]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 23 20:54:05 ciucalumio volumio[1731]: info: MPD Permissions set Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio volumio[1731]: info: Starting Shairport Sync Jun 23 20:54:05 ciucalumio volumio[1731]: SPOTIFY: User informations: {"country":"IT","display_name":"cape_it","email":"a.capecchiacci@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/cape_it"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/cape_it","id":"cape_it","images":[],"product":"premium","type":"user","uri":"spotify:user:cape_it"} Jun 23 20:54:05 ciucalumio volumio[1731]: info: Spotify Successfully logged in Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 23 20:54:05 ciucalumio volumio[1731]: info: [1750704845402] CoreMusicLibrary::Adding element Spotify Jun 23 20:54:05 ciucalumio sudo[2247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 23 20:54:05 ciucalumio sudo[2247]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:05 ciucalumio volumio[1731]: Cannot find translation for source Spotify Jun 23 20:54:05 ciucalumio volumio[1731]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 23 20:54:05 ciucalumio volumio[1731]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jun 23 20:54:05 ciucalumio volumio[1731]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 23 20:54:05 ciucalumio volumio[1731]: info: camilladsp spawned new process with pid 2255, instance 1, run: true Jun 23 20:54:05 ciucalumio volumio[1731]: info: camilladsp service started and running in background, instance 1 Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=debug msg="seek track to 0ms" Jun 23 20:54:05 ciucalumio volumio[1731]: cannot open device 'volumioHw': Device or resource busy Jun 23 20:54:05 ciucalumio volumio[1731]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 23 20:54:05 ciucalumio volumio[1731]: cannot open device 'volumioHw': Device or resource busy Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" Jun 23 20:54:05 ciucalumio volumio[1731]: info: FusionDsp loaded Jun 23 20:54:05 ciucalumio volumio[1731]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 23 20:54:05 ciucalumio sudo[2267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 23 20:54:05 ciucalumio sudo[2267]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:05 ciucalumio volumio[1731]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 23 20:54:05 ciucalumio volumio[1731]: info: Adding Signal Path Element [object Object] Jun 23 20:54:05 ciucalumio volumio[1731]: info: Adding fusiondspeq DSP Signal Path Element Jun 23 20:54:05 ciucalumio volumio[1731]: info: FusionDsp - ---- installed callbackRead Jun 23 20:54:05 ciucalumio volumio[1731]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=trace msg="emitting websocket event: seek" Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=debug msg="sending successful reply for delaer request" Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=debug msg="handling skip_next player command from e0dac72d7b2c7799460445bb163e059dfcc5c5b6" Jun 23 20:54:05 ciucalumio volumio[1731]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=debug msg="skip next track" Jun 23 20:54:05 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:05+02:00" level=debug msg="loading track spotify:track:3zBhihYUHBmGd2bcQIobrF (paused: false, position: 1ms)" Jun 23 20:54:05 ciucalumio 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. Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=trace msg="emitting websocket event: will_play" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:3zBhihYUHBmGd2bcQIobrF" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="requested aes key for file 73d5ccdc4d4beaf81d626e0f7726487ceb50d9cd, gid: 3zBhihYUHBmGd2bcQIobrF" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="fetched first chunk of 10, total size is 5209900 bytes" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate, raw: Jun 23 20:54:06 ciucalumio volumio[1731]: error: FusionDsp - invalid sample rate Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=info msg="loaded track \"(Sittin' On) the Dock of the Bay\" (uri: spotify:track:3zBhihYUHBmGd2bcQIobrF, paused: false, position: 1ms, duration: 163755ms)" Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 23 20:54:06 ciucalumio volumio[1731]: info: camilladsp stopping service pid 2255... Jun 23 20:54:06 ciucalumio volumio[1731]: info: camilladsp service terminated, instance 1 Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:54:06 ciucalumio volumio[1731]: info: camilladsp service started and running in background, instance 1 Jun 23 20:54:06 ciucalumio volumio[1731]: info: camilladsp spawned new process with pid 2273, instance 1, run: true Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="fetched chunk 2/9, size: 524288" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=trace msg="emitting websocket event: metadata" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="sending successful reply for delaer request" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="fetched chunk 1/9, size: 524288" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=trace msg="emitting websocket event: playing" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="handling skip_prev player command from e0dac72d7b2c7799460445bb163e059dfcc5c5b6" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="skip previous track" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="loading track spotify:track:72d38PCaL34IJULbV7rZ0o (paused: false, position: 1ms)" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="fetched chunk 3/9, size: 524288" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=trace msg="emitting websocket event: will_play" Jun 23 20:54:06 ciucalumio systemd[1]: mpd.service: Succeeded. Jun 23 20:54:06 ciucalumio systemd[1]: Stopped Music Player Daemon. Jun 23 20:54:06 ciucalumio sudo[2158]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:06 ciucalumio volumio[1731]: info: touch_display: systemctl daemon-reload succeeded. Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:72d38PCaL34IJULbV7rZ0o" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="requested aes key for file 6a72561d9643d93c9b981cdf87bd5119d1999977, gid: 72d38PCaL34IJULbV7rZ0o" Jun 23 20:54:06 ciucalumio sudo[2282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jun 23 20:54:06 ciucalumio sudo[2282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:06 ciucalumio systemd[1]: Reloading. Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="fetched first chunk of 20, total size is 10208316 bytes" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=info msg="loaded track \"Digging Your Scene\" (uri: spotify:track:72d38PCaL34IJULbV7rZ0o, paused: false, position: 1ms, duration: 254266ms)" Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:54:06 ciucalumio volumio[1731]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=trace msg="emitting websocket event: metadata" Jun 23 20:54:06 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:06+02:00" level=debug msg="sending successful reply for delaer request" Jun 23 20:54:07 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:07+02:00" level=debug msg="fetched chunk 1/19, size: 524288" Jun 23 20:54:07 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:07+02:00" level=debug msg="fetched chunk 3/19, size: 524288" Jun 23 20:54:07 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:07+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:07 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:07+02:00" level=trace msg="emitting websocket event: playing" Jun 23 20:54:07 ciucalumio go-librespot[1340]: time="2025-06-23T20:54:07+02:00" level=debug msg="fetched chunk 2/19, size: 524288" Jun 23 20:54:07 ciucalumio 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. Jun 23 20:54:07 ciucalumio volumio[1731]: info: camilladsp spawned new process with pid 2299, instance 1, run: true Jun 23 20:54:07 ciucalumio sudo[2156]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:07 ciucalumio volumio[1731]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jun 23 20:54:07 ciucalumio sudo[2189]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:07 ciucalumio sudo[2267]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:07 ciucalumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 23 20:54:07 ciucalumio volumio[1731]: info: Upmpdcli Daemon Started Jun 23 20:54:07 ciucalumio systemd[1]: Starting Music Player Daemon... Jun 23 20:54:07 ciucalumio systemd[1]: Stopping go-librespot Daemon... Jun 23 20:54:07 ciucalumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Jun 23 20:54:07 ciucalumio systemd[1]: go-librespot-daemon.service: Succeeded. Jun 23 20:54:07 ciucalumio systemd[1]: Stopped go-librespot Daemon. Jun 23 20:54:07 ciucalumio systemd[1]: shairport-sync.service: Succeeded. Jun 23 20:54:07 ciucalumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 23 20:54:07 ciucalumio sudo[2282]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:07 ciucalumio volumio[1731]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jun 23 20:54:07 ciucalumio volumio[1731]: info: touch_display: Volumio Kiosk started. Jun 23 20:54:07 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioGetState Jun 23 20:54:07 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:07 ciucalumio sudo[2154]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:07 ciucalumio volumio[1731]: info: Cannot mount NAS Music_FLAC at system boot, trial number 3 ,retrying in 5 seconds Jun 23 20:54:07 ciucalumio volumio[1731]: info: Cannot mount NAS Music_Mp3 at system boot, trial number 3 ,retrying in 5 seconds Jun 23 20:54:07 ciucalumio volumio[1731]: info: Cannot mount NAS Music_DSD at system boot, trial number 3 ,retrying in 5 seconds Jun 23 20:54:07 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioGetState Jun 23 20:54:07 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:07 ciucalumio volumio[1731]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jun 23 20:54:07 ciucalumio sudo[2307]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 23 20:54:07 ciucalumio sudo[2307]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 23 20:54:07 ciucalumio sudo[2307]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:08 ciucalumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 23 20:54:08 ciucalumio sudo[2187]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:08 ciucalumio sudo[2228]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:08 ciucalumio sudo[2196]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:08 ciucalumio systemd[1]: Started go-librespot Daemon. Jun 23 20:54:08 ciucalumio volumio[1731]: info: Shairport-Sync Started Jun 23 20:54:08 ciucalumio sudo[2247]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:08 ciucalumio sudo[2192]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:08 ciucalumio sudo[2170]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:08 ciucalumio volumio[1731]: Error adding Membership: Error: addMembership EINVAL Jun 23 20:54:08 ciucalumio go-librespot[2312]: Librespot-go daemon starting... Jun 23 20:54:08 ciucalumio volumio[1731]: info: Shairport-Sync Started Jun 23 20:54:08 ciucalumio volumio[1731]: info: Shairport-Sync Started Jun 23 20:54:08 ciucalumio volumio[1731]: info: Shairport-Sync Started Jun 23 20:54:08 ciucalumio volumio[1731]: info: Shairport-Sync Started Jun 23 20:54:08 ciucalumio volumio[1731]: info: touch_display: X display number found: 0 Jun 23 20:54:08 ciucalumio volumio[1731]: info: touch_display: X display number found: 0 Jun 23 20:54:08 ciucalumio volumio[1731]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jun 23 20:54:08 ciucalumio volumio[1731]: info: touch_display: X display number found: 0 Jun 23 20:54:08 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioGetState Jun 23 20:54:08 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:08 ciucalumio volumio[1731]: info: touch_display: Setting screensaver timeout to 120 seconds. Jun 23 20:54:08 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:08+02:00" level=info msg="generated new device id: c8405006ba55220eaa97116f4efd3b576fcaaec7" Jun 23 20:54:08 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:08+02:00" level=debug msg="stored credentials found for cape_it" Jun 23 20:54:08 ciucalumio volumio[1731]: info: camilladsp spawned new process with pid 2330, instance 1, run: true Jun 23 20:54:08 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:08+02:00" level=debug msg="obtained new client token: AAAXcJ581HrM7GP3n1mDDMuYUDk8YehfyOO8Zx0X0XfDVw/AlVOG/HZnyheMGY5qYvPboDkZXw7ohqv8FInnd/Hm0MN+p6a+glhXzGpfpFvzQR9Xu8Qudj9VDcr7PM6PLJNEwPJ/JMUr1gF3tVNvYWqIqjc8pv4yDZ0J6Fp4n9Hav99piHpFguBVyK3nGaXBc8/1WeJjrFfp53W1mGJmaN67TFpVIZ+cqvL1ZIHWyA0XRq1WyNHgmkdZP+LaETGd" Jun 23 20:54:08 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:08+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jun 23 20:54:08 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:08+02:00" level=debug msg="completed keyexchange" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="completed challenge" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="authenticated as cape_it" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="authenticated as cape_it" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="dealer connection opened" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 23 20:54:09 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:09+02:00" level=debug msg="received connection id: YzFmMjQ1MGQtYThjZi00NDY0LTkyOTItOGNjMmM2MTNhNTdiK2RlYWxlcit0Y3A6Ly8wYWNhNThhNC5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArQjRCMzY1N0ZCMUNENkM4Q0FCRTUyMTc4NDc5QjBDOTU3QjlGMzVGNkMyQUEzQThEQTMxMDQ0MEU5N0FFM0FFNQ==" Jun 23 20:54:09 ciucalumio mpd[2314]: Jun 23 20:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 23 20:54:10 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:10+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 339" Jun 23 20:54:10 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:10+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 23 20:54:10 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:10+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 23 20:54:10 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:10+02:00" level=debug msg="put connect state because NEW_DEVICE" Jun 23 20:54:10 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:10+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1393" Jun 23 20:54:10 ciucalumio systemd[1]: Started Music Player Daemon. Jun 23 20:54:10 ciucalumio sudo[2215]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:10 ciucalumio sudo[2109]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:10 ciucalumio sudo[2233]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:10 ciucalumio sudo[2118]: pam_unix(sudo:session): session closed for user root Jun 23 20:54:10 ciucalumio volumio[1731]: info: Completed starting Core Plugins Jun 23 20:54:10 ciucalumio volumio[1731]: info: ------------------------------------------- Jun 23 20:54:10 ciucalumio volumio[1731]: info: ----- MyVolumio plugins startup ---- Jun 23 20:54:10 ciucalumio volumio[1731]: info: ------------------------------------------- Jun 23 20:54:10 ciucalumio volumio[1731]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 23 20:54:11 ciucalumio volumio[1731]: error: MPD error: The expression evaluated to a falsy value: Jun 23 20:54:11 ciucalumio volumio[1731]: assert.ok(self.idling) Jun 23 20:54:11 ciucalumio volumio[1731]: error: The expression evaluated to a falsy value: Jun 23 20:54:11 ciucalumio volumio[1731]: assert.ok(self.idling) Jun 23 20:54:11 ciucalumio volumio[1731]: error: MPD error: The expression evaluated to a falsy value: Jun 23 20:54:11 ciucalumio volumio[1731]: assert.ok(self.idling) Jun 23 20:54:11 ciucalumio volumio[1731]: error: The expression evaluated to a falsy value: Jun 23 20:54:11 ciucalumio volumio[1731]: assert.ok(self.idling) Jun 23 20:54:11 ciucalumio volumio[1731]: error: MPD error: The expression evaluated to a falsy value: Jun 23 20:54:11 ciucalumio volumio[1731]: assert.ok(self.idling) Jun 23 20:54:11 ciucalumio volumio[1731]: error: The expression evaluated to a falsy value: Jun 23 20:54:11 ciucalumio volumio[1731]: assert.ok(self.idling) Jun 23 20:54:11 ciucalumio volumio[1731]: info: MPD running with PID2314 Jun 23 20:54:11 ciucalumio volumio[1731]: ,establishing connection Jun 23 20:54:11 ciucalumio volumio[1731]: error: updateQueue error: null Jun 23 20:54:11 ciucalumio volumio[1731]: error: updateQueue error: null Jun 23 20:54:11 ciucalumio volumio[1731]: info: go-librespot daemon successfully initialized Jun 23 20:54:11 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:54:11] [connect] Successful connection Jun 23 20:54:11 ciucalumio volumio-remote-updater[618]: [2025-06-23 20:54:11] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750704851 101 Jun 23 20:54:11 ciucalumio volumio[1731]: 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: 5 Jun 23 20:54:11 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:11+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 339" Jun 23 20:54:11 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:11+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 23 20:54:12 ciucalumio volumio[1731]: info: Cannot mount NAS Music_FLAC at system boot, trial number 4 ,retrying in 5 seconds Jun 23 20:54:12 ciucalumio volumio[1731]: info: Cannot mount NAS Music_Mp3 at system boot, trial number 4 ,retrying in 5 seconds Jun 23 20:54:12 ciucalumio volumio[1731]: info: Cannot mount NAS Music_DSD at system boot, trial number 4 ,retrying in 5 seconds Jun 23 20:54:14 ciucalumio volumio[1731]: info: Initializing connection to go-librespot Websocket Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="new websocket client" Jun 23 20:54:14 ciucalumio volumio[1731]: info: Connection to go-librespot Websocket established Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="handling transfer player command from e0dac72d7b2c7799460445bb163e059dfcc5c5b6" Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=trace msg="fetched new page 0 with 20 items (list: 20)" Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="loading track spotify:track:72d38PCaL34IJULbV7rZ0o (paused: false, position: 4803ms)" Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=trace msg="emitting websocket event: will_play" Jun 23 20:54:14 ciucalumio volumio[1731]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","play_origin":"playlist"}} Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:72d38PCaL34IJULbV7rZ0o" Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="requested aes key for file 6a72561d9643d93c9b981cdf87bd5119d1999977, gid: 72d38PCaL34IJULbV7rZ0o" Jun 23 20:54:14 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1331" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="fetched first chunk of 20, total size is 10208316 bytes" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=trace msg="seek to 4803ms (diff: 117ms, samples: 211812, bytes: 171902)" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1111" Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=info msg="loaded track \"Digging Your Scene\" (uri: spotify:track:72d38PCaL34IJULbV7rZ0o, paused: false, position: 4803ms, duration: 254266ms)" Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="fetched chunk 1/19, size: 524288" Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 23 20:54:15 ciucalumio volumio[1731]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=trace msg="emitting websocket event: metadata" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=trace msg="emitting websocket event: active" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="sending successful reply for delaer request" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 23 20:54:15 ciucalumio volumio[1731]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","name":"Digging Your Scene","artist_names":["The Blow Monkeys"],"album_name":"Animal Magic (Expanded Edition)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e027a5445556637a40162b128e9","position":4803,"duration":254266,"release_date":"year:1986","track_number":1,"disc_number":1}} Jun 23 20:54:15 ciucalumio volumio[1731]: SPOTIFY: received: {"type":"active","data":null} Jun 23 20:54:15 ciucalumio volumio[1731]: info: Aligning Spotify Volume to Volumio Volume Jun 23 20:54:15 ciucalumio volumio[1731]: info: CoreCommandRouter::volumioGetState Jun 23 20:54:15 ciucalumio volumio[1731]: info: CorePlayQueue::getTrack 0 Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="fetched chunk 2/19, size: 524288" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="fetched chunk 3/19, size: 524288" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 23 20:54:15 ciucalumio go-librespot[2312]: time="2025-06-23T20:54:15+02:00" level=trace msg="emitting websocket event: playing" Jun 23 20:54:15 ciucalumio volumio[1731]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:72d38PCaL34IJULbV7rZ0o","play_origin":"playlist"}} Jun 23 20:54:15 ciucalumio volumio[1731]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 20:54:15 ciucalumio volumio[1731]: TypeError: Cannot read property 'service' of undefined Jun 23 20:54:15 ciucalumio volumio[1731]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) Jun 23 20:54:15 ciucalumio volumio[1731]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:262:18) Jun 23 20:54:15 ciucalumio volumio[1731]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Jun 23 20:54:15 ciucalumio volumio[1731]: at WebSocket.emit (events.js:315:20) Jun 23 20:54:15 ciucalumio volumio[1731]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1203:20) Jun 23 20:54:15 ciucalumio volumio[1731]: at Receiver.emit (events.js:315:20) Jun 23 20:54:15 ciucalumio volumio[1731]: at /data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:608:16 Jun 23 20:54:15 ciucalumio volumio[1731]: at internal/process/task_queues.js:149:7 Jun 23 20:54:15 ciucalumio volumio[1731]: at AsyncResource.runInAsyncScope (async_hooks.js:197:9) Jun 23 20:54:15 ciucalumio volumio[1731]: at AsyncResource.runMicrotask (internal/process/task_queues.js:146:8) Jun 23 20:54:15 ciucalumio volumio[1731]: at runMicrotasks () Jun 23 20:54:15 ciucalumio volumio[1731]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jun 23 20:54:15 ciucalumio volumio[1731]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 23 20:54:15 ciucalumio sudo[2373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-23 20:53 Jun 23 20:54:15 ciucalumio sudo[2373]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"