Jan 11 22:41:00 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:41:00 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:03 volumio go-librespot[2275]: time="2026-01-11T22:41:03+08:00" level=debug msg="fetched chunk 14/18, size: 524288" uri="spotify:track:0Z913dVe5EaiRvtjknVe9R"
Jan 11 22:41:16 volumio go-librespot[2275]: time="2026-01-11T22:41:16+08:00" level=debug msg="fetched chunk 15/18, size: 524288" uri="spotify:track:0Z913dVe5EaiRvtjknVe9R"
Jan 11 22:41:17 volumio volumio[1546]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object]
Jan 11 22:41:17 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf
Jan 11 22:41:17 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:17 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:17 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:17 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:18 volumio volumio[1546]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object]
Jan 11 22:41:18 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf
Jan 11 22:41:18 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:18 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:18 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:18 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:20 volumio volumio[1546]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object]
Jan 11 22:41:20 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf
Jan 11 22:41:20 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:20 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:20 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:20 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:21 volumio go-librespot[2275]: time="2026-01-11T22:41:21+08:00" level=trace msg="sent dealer ping"
Jan 11 22:41:21 volumio go-librespot[2275]: time="2026-01-11T22:41:21+08:00" level=trace msg="received dealer pong"
Jan 11 22:41:27 volumio volumio[1546]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object]
Jan 11 22:41:27 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf
Jan 11 22:41:27 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:41:27 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:29 volumio go-librespot[2275]: time="2026-01-11T22:41:29+08:00" level=debug msg="fetched chunk 16/18, size: 524288" uri="spotify:track:0Z913dVe5EaiRvtjknVe9R"
Jan 11 22:41:32 volumio volumio[1546]: info: CoreCommandRouter::volumioNext
Jan 11 22:41:32 volumio volumio[1546]: info: CoreStateMachine::next
Jan 11 22:41:32 volumio volumio[1546]: info: Spotify next
Jan 11 22:41:32 volumio volumio[1546]: info: Sending Spotify command to local API: /player/next
Jan 11 22:41:32 volumio go-librespot[2275]: time="2026-01-11T22:41:32+08:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=trace msg="emitting websocket event: will_play"
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:album:38nSW52tvesTiHVUsWnJhA","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","play_origin":""}}
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:album:38nSW52tvesTiHVUsWnJhA","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","play_origin":""}}
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="selected format OGG_VORBIS_320 (5a79f887456c94f58842c25ddfb7868d6d4cc2a8)" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="requested aes key for file 5a79f887456c94f58842c25ddfb7868d6d4cc2a8, gid: 6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=trace msg="found 2 cdn urls" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="fetched first chunk of 15, total size is 7835104 bytes" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=info msg="loaded track \"Don't Let Me Be Misunderstood\" (paused: false, position: 0ms, duration: 206213ms, prefetched: false)" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="fetched chunk 2/14, size: 524288" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=trace msg="scheduling prefetch in 176s"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=trace msg="emitting websocket event: metadata"
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","name":"Don't Let Me Be Misunderstood","artist_names":["Alan Tam"],"album_name":"心手相連","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0231607aa009a5d5c220f92815","position":0,"duration":206213,"release_date":"year:1988 month:1 day:1","track_number":3,"disc_number":1}}
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","name":"Don't Let Me Be Misunderstood","artist_names":["Alan Tam"],"album_name":"心手相連","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0231607aa009a5d5c220f92815","position":0,"duration":206213,"release_date":"year:1988 month:1 day:1","track_number":3,"disc_number":1}}
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="fetched chunk 3/14, size: 524288" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jan 11 22:41:33 volumio go-librespot[2275]: time="2026-01-11T22:41:33+08:00" level=trace msg="emitting websocket event: playing"
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:album:38nSW52tvesTiHVUsWnJhA","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","resume":false,"play_origin":""}}
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: PUSH STATE SPOTIFY
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: {"status":"play","service":"spop","title":"Don't Let Me Be Misunderstood","artist":"Alan Tam","album":"心手相連","albumart":"https://i.scdn.co/image/ab67616d00001e0231607aa009a5d5c220f92815","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","trackType":"spotify","seek":0,"duration":206,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::servicePushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreStateMachine::pushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::volumioPushState
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:album:38nSW52tvesTiHVUsWnJhA","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","resume":false,"play_origin":""}}
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: PUSH STATE SPOTIFY
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: {"status":"play","service":"spop","title":"Don't Let Me Be Misunderstood","artist":"Alan Tam","album":"心手相連","albumart":"https://i.scdn.co/image/ab67616d00001e0231607aa009a5d5c220f92815","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","trackType":"spotify","seek":0,"duration":206,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::servicePushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreStateMachine::pushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::volumioPushState
Jan 11 22:41:33 volumio volumio[1546]: info: PeppySpectrum ---peppyspectrum status play
Jan 11 22:41:33 volumio volumio[1546]: info: PeppySpectrum ---peppyspectrum status play
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Jan 11 22:41:33 volumio sudo[3467]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jan 11 22:41:33 volumio sudo[3467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:33 volumio sudo[3469]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jan 11 22:41:33 volumio sudo[3469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:33 volumio systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon.
Jan 11 22:41:33 volumio sudo[3469]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:33 volumio volumio[1546]: info: peppyspectrum Daemon Started
Jan 11 22:41:33 volumio volumio[1546]: info: peppyspectrum Daemon Started
Jan 11 22:41:33 volumio sudo[3467]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: PUSH STATE SPOTIFY
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: {"status":"play","service":"spop","title":"Don't Let Me Be Misunderstood","artist":"Alan Tam","album":"心手相連","albumart":"https://i.scdn.co/image/ab67616d00001e0231607aa009a5d5c220f92815","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","trackType":"spotify","seek":0,"duration":206,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::servicePushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreStateMachine::pushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::volumioPushState
Jan 11 22:41:33 volumio volumio[1546]: info: PeppySpectrum ---peppyspectrum status play
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: PUSH STATE SPOTIFY
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: {"status":"play","service":"spop","title":"Don't Let Me Be Misunderstood","artist":"Alan Tam","album":"心手相連","albumart":"https://i.scdn.co/image/ab67616d00001e0231607aa009a5d5c220f92815","uri":"spotify:track:6f0mdV5l8PpDPHvuZM4o3R","trackType":"spotify","seek":0,"duration":206,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::servicePushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreStateMachine::pushState
Jan 11 22:41:33 volumio volumio[1546]: info: CoreCommandRouter::volumioPushState
Jan 11 22:41:33 volumio sudo[3475]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jan 11 22:41:33 volumio sudo[3475]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:33 volumio volumio[1546]: info: PeppySpectrum ---peppyspectrum status play
Jan 11 22:41:33 volumio volumio[1546]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72
Jan 11 22:41:33 volumio sudo[3478]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service
Jan 11 22:41:33 volumio sudo[3478]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:33 volumio sudo[3475]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:33 volumio volumio[1546]: info: peppyspectrum Daemon Started
Jan 11 22:41:33 volumio sudo[3478]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:33 volumio volumio[1546]: info: peppyspectrum Daemon Started
Jan 11 22:41:33 volumio systemd[1]: peppyspectrum.service: Deactivated successfully.
Jan 11 22:41:34 volumio go-librespot[2275]: time="2026-01-11T22:41:34+08:00" level=debug msg="fetched chunk 1/14, size: 524288" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:40 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 11 22:41:40 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jan 11 22:41:45 volumio volumio[1546]: info: Enabling plugin peppymeterbasic
Jan 11 22:41:45 volumio volumio[1546]: info: Loading plugin "peppymeterbasic"...
Jan 11 22:41:45 volumio volumio[1546]: info: Preparing to generate the ALSA configuration file
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Jan 11 22:41:45 volumio volumio[1546]: info: Reading ALSA contributions from plugins.
Jan 11 22:41:45 volumio volumio[1546]: info: Asound.conf file written
Jan 11 22:41:45 volumio sudo[3528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jan 11 22:41:45 volumio sudo[3528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:45 volumio sudo[3528]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:45 volumio volumio[1546]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Jan 11 22:41:45 volumio volumio[1546]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Jan 11 22:41:45 volumio volumio[1546]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2
Jan 11 22:41:45 volumio volumio[1546]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2
Jan 11 22:41:45 volumio volumio[1546]: info: Output device has changed, restarting MPD
Jan 11 22:41:45 volumio volumio[1546]: info: Output device has changed, restarting Shairport Sync
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:45 volumio sudo[3536]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 11 22:41:45 volumio sudo[3536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:45 volumio sudo[3535]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 11 22:41:45 volumio sudo[3535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:45 volumio volumio[1546]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 11 22:41:45 volumio sudo[3535]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:45 volumio volumio[1546]: info: PLUGIN START: peppymeterbasic
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jan 11 22:41:45 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Jan 11 22:41:45 volumio volumio[1546]: info: Preparing to generate the ALSA configuration file
Jan 11 22:41:45 volumio sudo[3546]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2
Jan 11 22:41:45 volumio sudo[3546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:45 volumio sudo[3546]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:45 volumio volumio[1546]: info: Done.
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
Jan 11 22:41:45 volumio volumio[1546]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Jan 11 22:41:45 volumio volumio[1546]: info: Reading ALSA contributions from plugins.
Jan 11 22:41:45 volumio volumio[1546]: info: snd_dummy loaded
Jan 11 22:41:45 volumio volumio[1546]: info: MPD Permissions set
Jan 11 22:41:45 volumio systemd[1]: mpd.service: Deactivated successfully.
Jan 11 22:41:45 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Jan 11 22:41:45 volumio systemd[1]: mpd.socket: Deactivated successfully.
Jan 11 22:41:45 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Jan 11 22:41:45 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Jan 11 22:41:45 volumio volumio[1546]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:45 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Jan 11 22:41:46 volumio volumio[1546]: info: Starting Shairport Sync
Jan 11 22:41:46 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Jan 11 22:41:46 volumio volumio[1546]: info: Asound.conf file unchanged, so no further update is needed
Jan 11 22:41:46 volumio volumio[1546]: info: Output device has changed, restarting MPD
Jan 11 22:41:46 volumio sudo[3558]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 11 22:41:46 volumio sudo[3558]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:46 volumio volumio[1546]: info: Output device has changed, restarting Shairport Sync
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:46 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Jan 11 22:41:46 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Jan 11 22:41:46 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Jan 11 22:41:46 volumio systemd[1]: shairport-sync.service: Consumed 1.620s CPU time.
Jan 11 22:41:46 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Jan 11 22:41:46 volumio sudo[3563]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 11 22:41:46 volumio sudo[3562]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 11 22:41:46 volumio sudo[3562]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:46 volumio sudo[3563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:46 volumio sudo[3563]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:46 volumio volumio[1546]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 11 22:41:46 volumio sudo[3558]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:46 volumio sudo[3556]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 11 22:41:46 volumio sudo[3556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jan 11 22:41:46 volumio sudo[3556]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:46 volumio volumio[1546]: info: MPD Permissions set
Jan 11 22:41:46 volumio volumio[1546]: info: Shairport-Sync Started
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio systemd[1]: mpd.service: Deactivated successfully.
Jan 11 22:41:46 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Jan 11 22:41:46 volumio systemd[1]: mpd.socket: Deactivated successfully.
Jan 11 22:41:46 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Jan 11 22:41:46 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Jan 11 22:41:46 volumio volumio[1546]: info: Starting Shairport Sync
Jan 11 22:41:46 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Jan 11 22:41:46 volumio sudo[3598]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 11 22:41:46 volumio sudo[3598]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:46 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Jan 11 22:41:46 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Jan 11 22:41:46 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Jan 11 22:41:46 volumio sudo[3596]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 11 22:41:46 volumio sudo[3596]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jan 11 22:41:46 volumio sudo[3596]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:46 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Jan 11 22:41:46 volumio sudo[3598]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:46 volumio volumio[1546]: info: Shairport-Sync Started
Jan 11 22:41:46 volumio volumio[1546]: (node:1546) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jan 11 22:41:46 volumio volumio[1546]: (Use `node --trace-warnings ...` to show where the warning was created)
Jan 11 22:41:46 volumio volumio[1546]: (node:1546) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jan 11 22:41:46 volumio volumio[1546]: (node:1546) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jan 11 22:41:46 volumio volumio[1546]: (node:1546) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jan 11 22:41:46 volumio volumio[1546]: (node:1546) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 11 22:41:46 volumio go-librespot[2275]: time="2026-01-11T22:41:46+08:00" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:41:46 volumio mpd[3602]: 2026-01-11T22:41:46 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jan 11 22:41:46 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Jan 11 22:41:46 volumio sudo[3562]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:46 volumio sudo[3536]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:46 volumio volumio[1546]: error: MPD error: The expression evaluated to a falsy value:
Jan 11 22:41:46 volumio volumio[1546]: assert.ok(self.idling)
Jan 11 22:41:46 volumio volumio[1546]: error: The expression evaluated to a falsy value:
Jan 11 22:41:46 volumio volumio[1546]: assert.ok(self.idling)
Jan 11 22:41:46 volumio volumio[1546]: error: updateQueue error: null
Jan 11 22:41:47 volumio volumio[1546]: error: peppy_screensaver: Error start PeppyMeter: Error: Command failed: /data/plugins/user_interface/peppy_screensaver/run_peppymeter.sh
Jan 11 22:41:47 volumio volumio[1546]: Traceback (most recent call last):
Jan 11 22:41:47 volumio volumio[1546]: File "/data/plugins/user_interface/peppy_screensaver/./screensaver/volumio_peppymeter.py", line 29, in
Jan 11 22:41:47 volumio volumio[1546]: from volumio_albumart import AlbumartAnimator
Jan 11 22:41:47 volumio volumio[1546]: File "/data/plugins/user_interface/peppy_screensaver/screensaver/volumio_albumart.py", line 12, in
Jan 11 22:41:47 volumio volumio[1546]: import socketio
Jan 11 22:41:47 volumio volumio[1546]: ModuleNotFoundError: No module named 'socketio'
Jan 11 22:41:49 volumio sudo[3624]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 11 22:41:49 volumio sudo[3624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:49 volumio sudo[3626]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 11 22:41:49 volumio sudo[3626]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:49 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service...
Jan 11 22:41:49 volumio systemd[1]: mpd_monitor.service: Deactivated successfully.
Jan 11 22:41:49 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service.
Jan 11 22:41:49 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service.
Jan 11 22:41:49 volumio sudo[3624]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:49 volumio mpd_monitor.sh[3629]: MPD Monitor Service: Starting MPD Monitor Service
Jan 11 22:41:49 volumio volumio[1546]: info: Successfully started MPD Monitor
Jan 11 22:41:49 volumio sudo[3626]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:49 volumio volumio[1546]: info: Successfully started MPD Monitor
Jan 11 22:41:50 volumio go-librespot[2275]: time="2026-01-11T22:41:50+08:00" level=trace msg="received accesspoint ping"
Jan 11 22:41:50 volumio go-librespot[2275]: time="2026-01-11T22:41:50+08:00" level=trace msg="received accesspoint pong ack"
Jan 11 22:41:51 volumio go-librespot[2275]: time="2026-01-11T22:41:51+08:00" level=trace msg="sent dealer ping"
Jan 11 22:41:51 volumio go-librespot[2275]: time="2026-01-11T22:41:51+08:00" level=trace msg="received dealer pong"
Jan 11 22:41:52 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:41:55 volumio volumio[1546]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object]
Jan 11 22:41:55 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy
Jan 11 22:41:55 volumio volumio[1546]: aaaaaaaaaaa 800,480
Jan 11 22:41:55 volumio volumio[1546]: info: PeppySpectrum ---800480
Jan 11 22:41:55 volumio volumio[1546]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then')
Jan 11 22:41:55 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:41:55 volumio volumio[1546]: info: CoreCommandRouter::Close All Modals sent
Jan 11 22:41:56 volumio volumio[1546]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object]
Jan 11 22:41:56 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy
Jan 11 22:41:56 volumio volumio[1546]: aaaaaaaaaaa 800,480
Jan 11 22:41:56 volumio volumio[1546]: info: PeppySpectrum ---800480
Jan 11 22:41:56 volumio volumio[1546]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then')
Jan 11 22:41:56 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:41:56 volumio volumio[1546]: info: CoreCommandRouter::Close All Modals sent
Jan 11 22:41:59 volumio volumio[1546]: info: CALLMETHOD: user_interface peppyspectrum savepeppy1 [object Object]
Jan 11 22:41:59 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy1
Jan 11 22:41:59 volumio volumio[1546]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then')
Jan 11 22:41:59 volumio volumio[1546]: info: PeppySpectrum -----------------------spectrums.3
Jan 11 22:41:59 volumio volumio[1546]: info: PeppySpectrum -----------------------$basefolder
Jan 11 22:41:59 volumio volumio[1546]: info: PeppySpectrum -----------------------screensize800x480
Jan 11 22:41:59 volumio volumio[1546]: info: PeppySpectrum -----------------------screenwidth
Jan 11 22:41:59 volumio volumio[1546]: info: PeppySpectrum -----------------------screenheight
Jan 11 22:41:59 volumio volumio[1546]: info: PeppySpectrum -----------------------spectrumsize30
Jan 11 22:41:59 volumio volumio[1546]: error: PeppySpectrum ---Error writing config null
Jan 11 22:41:59 volumio sudo[3650]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart peppyspectrum.service
Jan 11 22:41:59 volumio sudo[3650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 11 22:41:59 volumio systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon.
Jan 11 22:41:59 volumio sudo[3650]: pam_unix(sudo:session): session closed for user root
Jan 11 22:41:59 volumio volumio[1546]: info: peppyspectrum Daemon Started
Jan 11 22:41:59 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:41:59 volumio volumio[1546]: info: CoreCommandRouter::Close All Modals sent
Jan 11 22:41:59 volumio go-librespot[2275]: time="2026-01-11T22:41:59+08:00" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:42:00 volumio startpeppyspectrum.sh[3653]: libpng warning: iCCP: known incorrect sRGB profile
Jan 11 22:42:00 volumio startpeppyspectrum.sh[3653]: libpng warning: iCCP: known incorrect sRGB profile
Jan 11 22:42:00 volumio startpeppyspectrum.sh[3653]: libpng warning: iCCP: known incorrect sRGB profile
Jan 11 22:42:12 volumio volumio[1546]: info: CALLMETHOD: user_interface peppyspectrum updatelist
Jan 11 22:42:12 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , updatelist
Jan 11 22:42:12 volumio volumio[1546]: info: PeppySpectrum --- wget 'https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt'
Jan 11 22:42:13 volumio go-librespot[2275]: time="2026-01-11T22:42:13+08:00" level=debug msg="fetched chunk 6/14, size: 524288" uri="spotify:track:6f0mdV5l8PpDPHvuZM4o3R"
Jan 11 22:42:13 volumio volumio[1546]: --2026-01-11 22:42:12-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt
Jan 11 22:42:13 volumio volumio[1546]: Resolving github.com (github.com)... 20.205.243.166
Jan 11 22:42:13 volumio volumio[1546]: Connecting to github.com (github.com)|20.205.243.166|:443... connected.
Jan 11 22:42:13 volumio volumio[1546]: HTTP request sent, awaiting response... 302 Found
Jan 11 22:42:13 volumio volumio[1546]: Location: https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt [following]
Jan 11 22:42:13 volumio volumio[1546]: --2026-01-11 22:42:13-- https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt
Jan 11 22:42:13 volumio volumio[1546]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.108.133, 185.199.111.133, 185.199.109.133, ...
Jan 11 22:42:13 volumio volumio[1546]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.108.133|:443... connected.
Jan 11 22:42:13 volumio volumio[1546]: HTTP request sent, awaiting response... 200 OK
Jan 11 22:42:13 volumio volumio[1546]: Length: 471 [text/plain]
Jan 11 22:42:13 volumio volumio[1546]: Saving to: ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’
Jan 11 22:42:13 volumio volumio[1546]: 0K 100% 15.1M=0s
Jan 11 22:42:13 volumio volumio[1546]: 2026-01-11 22:42:13 (15.1 MB/s) - ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ saved [471/471]
Jan 11 22:42:13 volumio volumio[1546]: info: CALLMETHOD: user_interface peppyspectrum updatelist
Jan 11 22:42:13 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , updatelist
Jan 11 22:42:13 volumio volumio[1546]: info: PeppySpectrum --- wget 'https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt'
Jan 11 22:42:14 volumio volumio[1546]: --2026-01-11 22:42:13-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt
Jan 11 22:42:14 volumio volumio[1546]: Resolving github.com (github.com)... 20.205.243.166
Jan 11 22:42:14 volumio volumio[1546]: Connecting to github.com (github.com)|20.205.243.166|:443... connected.
Jan 11 22:42:14 volumio volumio[1546]: HTTP request sent, awaiting response... 302 Found
Jan 11 22:42:14 volumio volumio[1546]: Location: https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt [following]
Jan 11 22:42:14 volumio volumio[1546]: --2026-01-11 22:42:13-- https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt
Jan 11 22:42:14 volumio volumio[1546]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.110.133, 185.199.108.133, 185.199.111.133, ...
Jan 11 22:42:14 volumio volumio[1546]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.110.133|:443... connected.
Jan 11 22:42:14 volumio volumio[1546]: HTTP request sent, awaiting response... 200 OK
Jan 11 22:42:14 volumio volumio[1546]: Length: 471 [text/plain]
Jan 11 22:42:14 volumio volumio[1546]: Saving to: ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’
Jan 11 22:42:14 volumio volumio[1546]: 0K 100% 9.07M=0s
Jan 11 22:42:14 volumio volumio[1546]: 2026-01-11 22:42:14 (9.07 MB/s) - ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ saved [471/471]
Jan 11 22:42:14 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:42:14 volumio volumio[1546]: info: CoreCommandRouter::Close All Modals sent
Jan 11 22:42:14 volumio volumio[1546]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 11 22:42:14 volumio volumio[1546]: info: CoreCommandRouter::Close All Modals sent
Jan 11 22:42:15 volumio volumio[1546]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object]
Jan 11 22:42:15 volumio volumio[1546]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum
Jan 11 22:42:18 volumio volumio[1546]: --2026-01-11 22:42:15-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose
Jan 11 22:42:18 volumio volumio[1546]: Resolving github.com (github.com)... 20.205.243.166
Jan 11 22:42:18 volumio volumio[1546]: Connecting to github.com (github.com)|20.205.243.166|:443... connected.
Jan 11 22:42:18 volumio volumio[1546]: HTTP request sent, awaiting response... 404 Not Found
Jan 11 22:42:18 volumio volumio[1546]: 2026-01-11 22:42:16 ERROR 404: Not Found.
Jan 11 22:42:18 volumio volumio[1546]: --2026-01-11 22:42:16-- http://a/
Jan 11 22:42:18 volumio volumio[1546]: Resolving a (a)... failed: Device or resource busy.
Jan 11 22:42:18 volumio volumio[1546]: wget: unable to resolve host address ‘a’
Jan 11 22:42:18 volumio volumio[1546]: --2026-01-11 22:42:16-- http://packet.zip/
Jan 11 22:42:18 volumio volumio[1546]: Resolving packet.zip (packet.zip)... 162.255.119.167
Jan 11 22:42:18 volumio volumio[1546]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected.
Jan 11 22:42:18 volumio volumio[1546]: HTTP request sent, awaiting response... 302 Found
Jan 11 22:42:18 volumio volumio[1546]: Location: http://www.packet.zip/ [following]
Jan 11 22:42:18 volumio volumio[1546]: --2026-01-11 22:42:18-- http://www.packet.zip/
Jan 11 22:42:18 volumio volumio[1546]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19
Jan 11 22:42:18 volumio volumio[1546]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected.
Jan 11 22:42:18 volumio volumio[1546]: HTTP request sent, awaiting response... 403 Forbidden
Jan 11 22:42:18 volumio volumio[1546]: 2026-01-11 22:42:18 ERROR 403: Forbidden.
Jan 11 22:42:18 volumio volumio[1546]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums
Jan 11 22:42:18 volumio volumio[1546]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory
Jan 11 22:42:18 volumio volumio[1546]: /bin/rm: cannot remove 'a': No such file or directory
Jan 11 22:42:18 volumio volumio[1546]: /bin/rm: cannot remove 'packet.zip*': No such file or directory
Jan 11 22:42:18 volumio volumio[1546]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 11 22:42:18 volumio volumio[1546]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip*
Jan 11 22:42:18 volumio volumio[1546]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory
Jan 11 22:42:18 volumio volumio[1546]: /bin/rm: cannot remove 'a': No such file or directory
Jan 11 22:42:18 volumio volumio[1546]: /bin/rm: cannot remove 'packet.zip*': No such file or directory
Jan 11 22:42:18 volumio volumio[1546]: at checkExecSyncError (node:child_process:887:11)
Jan 11 22:42:18 volumio volumio[1546]: at execSync (node:child_process:959:15)
Jan 11 22:42:18 volumio volumio[1546]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19
Jan 11 22:42:18 volumio volumio[1546]: at new Promise ()
Jan 11 22:42:18 volumio volumio[1546]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12)
Jan 11 22:42:18 volumio volumio[1546]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32)
Jan 11 22:42:18 volumio volumio[1546]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42)
Jan 11 22:42:18 volumio volumio[1546]: at Socket.emit (node:events:514:28)
Jan 11 22:42:18 volumio volumio[1546]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Jan 11 22:42:18 volumio volumio[1546]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) {
Jan 11 22:42:18 volumio volumio[1546]: status: 1,
Jan 11 22:42:18 volumio volumio[1546]: signal: null,
Jan 11 22:42:18 volumio volumio[1546]: output: [
Jan 11 22:42:18 volumio volumio[1546]: null,
Jan 11 22:42:18 volumio volumio[1546]: ,
Jan 11 22:42:18 volumio volumio[1546]:
Jan 11 22:42:18 volumio volumio[1546]: ],
Jan 11 22:42:18 volumio volumio[1546]: pid: 3704,
Jan 11 22:42:18 volumio volumio[1546]: stdout: ,
Jan 11 22:42:18 volumio volumio[1546]: stderr:
Jan 11 22:42:18 volumio volumio[1546]: }
Jan 11 22:42:18 volumio volumio[1546]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 11 22:42:19 volumio sudo[3720]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-11 22:41'
Jan 11 22:42:19 volumio sudo[3720]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"