Feb 21 18:43:26 volumio volumio[1002]: info: CoreCommandRouter::volumioGetState Feb 21 18:43:26 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:43:28 volumio volumio[1002]: info: CoreCommandRouter::volumioPlay Feb 21 18:43:28 volumio volumio[1002]: info: CoreStateMachine::play index undefined Feb 21 18:43:28 volumio volumio[1002]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 18:43:28 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:43:28 volumio volumio[1002]: info: CoreStateMachine::startPlaybackTimer Feb 21 18:43:28 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:43:28 volumio volumio[1002]: info: [1771670608196] ControllerWebradio::clearAddPlayTrack Feb 21 18:43:28 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 18:43:28 volumio volumio[1002]: info: sendMpdCommand stop took 1 milliseconds Feb 21 18:43:28 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 18:43:28 volumio volumio[1002]: info: Feb 21 18:43:28 volumio volumio[1002]: ---------------------------- MPD announces system playlist update Feb 21 18:43:28 volumio volumio[1002]: info: Ignoring MPD Status Update Feb 21 18:43:28 volumio volumio[1002]: info: sendMpdCommand clear took 2 milliseconds Feb 21 18:43:28 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand load "https://lhttp.qingting.fm/live/15318569/64k.mp3" Feb 21 18:43:28 volumio volumio[1002]: error: updateQueue error: null Feb 21 18:43:28 volumio volumio[1002]: info: ------------------------------ 6ms Feb 21 18:43:28 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand add "https://lhttp.qingting.fm/live/15318569/64k.mp3" Feb 21 18:43:28 volumio volumio[1002]: info: Feb 21 18:43:28 volumio volumio[1002]: ---------------------------- MPD announces system playlist update Feb 21 18:43:28 volumio volumio[1002]: info: Ignoring MPD Status Update Feb 21 18:43:28 volumio volumio[1002]: info: sendMpdCommand add "https://lhttp.qingting.fm/live/15318569/64k.mp3" took 1 milliseconds Feb 21 18:43:28 volumio volumio[1002]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 18:43:28 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand play Feb 21 18:43:28 volumio volumio[1002]: info: ------------------------------ 2ms Feb 21 18:43:28 volumio volumio[1002]: info: sendMpdCommand play took 1 milliseconds Feb 21 18:43:29 volumio volumio[1002]: info: Feb 21 18:43:29 volumio volumio[1002]: ---------------------------- MPD announces state update: player Feb 21 18:43:29 volumio volumio[1002]: info: ControllerMpd::getState Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:43:29 volumio volumio[1002]: info: Feb 21 18:43:29 volumio volumio[1002]: ---------------------------- MPD announces state update: player Feb 21 18:43:29 volumio volumio[1002]: info: sendMpdCommand status took 8 milliseconds Feb 21 18:43:29 volumio volumio[1002]: info: ControllerMpd::getState Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::parseState Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:43:29 volumio volumio[1002]: info: sendMpdCommand status took 3 milliseconds Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::parseState Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:43:29 volumio volumio[1002]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 21 18:43:29 volumio volumio[1002]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:43:29 volumio volumio[1002]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:43:29 volumio volumio[1002]: info: ControllerMpd::pushState Feb 21 18:43:29 volumio volumio[1002]: info: CoreCommandRouter::servicePushState Feb 21 18:43:29 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:43:29 volumio volumio[1002]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64k.mp3","artist":null,"album":null,"uri":"https://lhttp.qingting.fm/live/15318569/64k.mp3","trackType":"mp3"} Feb 21 18:43:29 volumio volumio[1002]: verbose: CURRENT POSITION 0 Feb 21 18:43:29 volumio volumio[1002]: info: CoreStateMachine::syncState stateService play Feb 21 18:43:29 volumio volumio[1002]: info: CoreStateMachine::syncState currentStatus stop Feb 21 18:43:29 volumio volumio[1002]: info: ControllerMpd::pushState Feb 21 18:43:29 volumio volumio[1002]: info: CoreCommandRouter::servicePushState Feb 21 18:43:29 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:43:29 volumio volumio[1002]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"64k.mp3","artist":null,"album":null,"uri":"https://lhttp.qingting.fm/live/15318569/64k.mp3","trackType":"mp3"} Feb 21 18:43:29 volumio volumio[1002]: verbose: CURRENT POSITION 0 Feb 21 18:43:29 volumio volumio[1002]: info: CoreStateMachine::syncState stateService play Feb 21 18:43:29 volumio volumio[1002]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:43:29 volumio volumio[1002]: info: Received an update from plugin. extracting info from payload Feb 21 18:43:29 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:43:29 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:43:29 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:43:29 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:43:29 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:43:29 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:43:29 volumio volumio[1002]: info: ------------------------------ 29ms Feb 21 18:43:29 volumio volumio[1002]: info: ------------------------------ 31ms Feb 21 18:43:35 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 21 18:43:35 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 21 18:43:38 volumio volumio[1002]: info: Enabling plugin peppyspectrum Feb 21 18:43:38 volumio volumio[1002]: info: Loading plugin "peppyspectrum"... Feb 21 18:43:38 volumio volumio[1002]: info: Preparing to generate the ALSA configuration file Feb 21 18:43:38 volumio volumio[1002]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 21 18:43:38 volumio volumio[1002]: info: Reading ALSA contributions from plugins. Feb 21 18:43:38 volumio volumio[1002]: info: Asound.conf file written Feb 21 18:43:38 volumio sudo[6491]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 21 18:43:38 volumio sudo[6491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:39 volumio sudo[6491]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:39 volumio volumio[1002]: No state is present for card Generic Feb 21 18:43:39 volumio volumio[1002]: Found hardware: "HDA-Intel" "ATI R6xx HDMI" "HDA:1002aa01,00aa0100,00100200" "0x1022" "0x1511" Feb 21 18:43:39 volumio volumio[1002]: Hardware is initialized using a generic method Feb 21 18:43:39 volumio volumio[1002]: No state is present for card Generic Feb 21 18:43:39 volumio volumio[1002]: No state is present for card SB Feb 21 18:43:39 volumio volumio[1002]: Found hardware: "HDA-Intel" "Realtek Generic" "HDA:10ec0887,10ec0887,00100302" "0x1002" "0x4383" Feb 21 18:43:39 volumio volumio[1002]: Hardware is initialized using a generic method Feb 21 18:43:39 volumio volumio[1002]: No state is present for card SB Feb 21 18:43:39 volumio volumio[1002]: info: Output device has changed, restarting MPD Feb 21 18:43:39 volumio volumio[1002]: info: Output device has changed, restarting Shairport Sync Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:43:39 volumio sudo[6497]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 18:43:39 volumio sudo[6497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:39 volumio sudo[6497]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:39 volumio sudo[6500]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 18:43:39 volumio sudo[6500]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:39 volumio volumio[1002]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 21 18:43:39 volumio volumio[1002]: info: PLUGIN START: peppyspectrum Feb 21 18:43:39 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 21 18:43:39 volumio volumio[1002]: info: Preparing to generate the ALSA configuration file Feb 21 18:43:39 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 21 18:43:39 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 21 18:43:39 volumio systemd[1]: mpd.service: Consumed 11.367s CPU time. Feb 21 18:43:39 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 21 18:43:39 volumio sudo[6507]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Feb 21 18:43:39 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 21 18:43:39 volumio sudo[6507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:39 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 21 18:43:39 volumio volumio[1002]: info: Done. Feb 21 18:43:39 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 21 18:43:39 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 21 18:43:39 volumio volumio[1002]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 21 18:43:39 volumio volumio[1002]: info: Reading ALSA contributions from plugins. Feb 21 18:43:39 volumio volumio[1002]: info: MPD Permissions set Feb 21 18:43:39 volumio volumio[1002]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 21 18:43:39 volumio sudo[6507]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:39 volumio volumio[1002]: info: snd_dummy loaded Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio (udev-worker)[6522]: controlC7: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 7' failed with exit code 99. Feb 21 18:43:39 volumio volumio[1002]: info: Starting Shairport Sync Feb 21 18:43:39 volumio sudo[6512]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 18:43:39 volumio sudo[6512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 18:43:39 volumio sudo[6512]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:39 volumio sudo[6528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 18:43:39 volumio volumio[1002]: info: Asound.conf file unchanged, so no further update is needed Feb 21 18:43:39 volumio volumio[1002]: info: Output device has changed, restarting MPD Feb 21 18:43:39 volumio sudo[6528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:39 volumio volumio[1002]: info: Output device has changed, restarting Shairport Sync Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:43:39 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 21 18:43:39 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 21 18:43:39 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 21 18:43:39 volumio systemd[1]: shairport-sync.service: Consumed 8.041s CPU time. Feb 21 18:43:39 volumio sudo[6533]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 18:43:39 volumio sudo[6533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:39 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 21 18:43:39 volumio sudo[6535]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 18:43:39 volumio sudo[6535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:39 volumio sudo[6528]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:39 volumio sudo[6533]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:39 volumio volumio[1002]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 21 18:43:39 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 21 18:43:39 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 21 18:43:39 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 21 18:43:39 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 21 18:43:39 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 21 18:43:39 volumio volumio[1002]: info: MPD Permissions set Feb 21 18:43:39 volumio volumio[1002]: info: Shairport-Sync Started Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 21 18:43:39 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 21 18:43:39 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 18:43:39 volumio volumio[1002]: info: Starting Shairport Sync Feb 21 18:43:40 volumio sudo[6564]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 18:43:40 volumio sudo[6564]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 18:43:40 volumio sudo[6564]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:40 volumio sudo[6574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 18:43:40 volumio sudo[6574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:40 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 21 18:43:40 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 21 18:43:40 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 21 18:43:40 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 21 18:43:40 volumio sudo[6574]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:40 volumio volumio[1002]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:43:40 volumio volumio[1002]: info: Shairport-Sync Started Feb 21 18:43:42 volumio mpd[6576]: 2026-02-21T18:43:42 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 21 18:43:42 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 21 18:43:42 volumio sudo[6500]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:42 volumio sudo[6535]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:42 volumio volumio[1002]: error: MPD error: The expression evaluated to a falsy value: Feb 21 18:43:42 volumio volumio[1002]: assert.ok(self.idling) Feb 21 18:43:42 volumio volumio[1002]: error: The expression evaluated to a falsy value: Feb 21 18:43:42 volumio volumio[1002]: assert.ok(self.idling) Feb 21 18:43:42 volumio volumio[1002]: error: updateQueue error: null Feb 21 18:43:44 volumio volumio[1002]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 21 18:43:44 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 21 18:43:44 volumio volumio[1002]: aaaaaaaaaaa 1280,400 Feb 21 18:43:44 volumio volumio[1002]: info: PeppySpectrum ---1280400 Feb 21 18:43:44 volumio volumio[1002]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 21 18:43:44 volumio volumio[1002]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:43:44 volumio volumio[1002]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:43:45 volumio volumio[1002]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 21 18:43:45 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 21 18:43:45 volumio volumio[1002]: aaaaaaaaaaa 1280,400 Feb 21 18:43:45 volumio volumio[1002]: info: PeppySpectrum ---1280400 Feb 21 18:43:45 volumio volumio[1002]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 21 18:43:45 volumio volumio[1002]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:43:45 volumio volumio[1002]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:43:51 volumio volumio[1002]: info: CALLMETHOD: user_interface peppyspectrum savepeppy1 [object Object] Feb 21 18:43:51 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy1 Feb 21 18:43:51 volumio volumio[1002]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 21 18:43:51 volumio volumio[1002]: info: PeppySpectrum -----------------------spectrums.2 Feb 21 18:43:51 volumio volumio[1002]: info: PeppySpectrum -----------------------$basefolder Feb 21 18:43:51 volumio volumio[1002]: info: PeppySpectrum -----------------------screensize1280x400 Feb 21 18:43:51 volumio volumio[1002]: info: PeppySpectrum -----------------------screenwidth Feb 21 18:43:51 volumio volumio[1002]: info: PeppySpectrum -----------------------screenheight Feb 21 18:43:51 volumio volumio[1002]: info: PeppySpectrum -----------------------spectrumsize30 Feb 21 18:43:51 volumio volumio[1002]: error: PeppySpectrum ---Error writing config null Feb 21 18:43:51 volumio sudo[6621]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart peppyspectrum.service Feb 21 18:43:51 volumio sudo[6621]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:51 volumio systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 21 18:43:51 volumio sudo[6621]: pam_unix(sudo:session): session closed for user root Feb 21 18:43:51 volumio volumio[1002]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:43:51 volumio volumio[1002]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:43:51 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:43:53 volumio startpeppyspectrum.sh[6624]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:43:53 volumio startpeppyspectrum.sh[6624]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:43:53 volumio startpeppyspectrum.sh[6624]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:43:59 volumio volumio[1002]: info: CALLMETHOD: user_interface peppyspectrum delayspectrum [object Object] Feb 21 18:43:59 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , delayspectrum Feb 21 18:43:59 volumio volumio[1002]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 21 18:43:59 volumio volumio[1002]: info: PeppySpectrum -----------------------spectrums.2 Feb 21 18:43:59 volumio volumio[1002]: info: PeppySpectrum -----------------------$basefolder Feb 21 18:43:59 volumio volumio[1002]: info: PeppySpectrum -----------------------screensize1280x400 Feb 21 18:43:59 volumio volumio[1002]: info: PeppySpectrum -----------------------screenwidth Feb 21 18:43:59 volumio volumio[1002]: info: PeppySpectrum -----------------------screenheight Feb 21 18:43:59 volumio volumio[1002]: info: PeppySpectrum -----------------------spectrumsize30 Feb 21 18:43:59 volumio volumio[1002]: error: PeppySpectrum ---Error writing config null Feb 21 18:43:59 volumio sudo[6656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart peppyspectrum.service Feb 21 18:43:59 volumio sudo[6656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:43:59 volumio systemd[1]: Stopping peppyspectrum.service - peppyspectrum Daemon... Feb 21 18:43:59 volumio volumio[1002]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:43:59 volumio volumio[1002]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:44:00 volumio systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 21 18:44:00 volumio systemd[1]: Stopped peppyspectrum.service - peppyspectrum Daemon. Feb 21 18:44:00 volumio systemd[1]: peppyspectrum.service: Consumed 2.854s CPU time. Feb 21 18:44:00 volumio systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 21 18:44:00 volumio sudo[6656]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:00 volumio startpeppyspectrum.sh[6659]: sleep: invalid time interval ‘undefined’ Feb 21 18:44:00 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:00 volumio startpeppyspectrum.sh[6659]: Try 'sleep --help' for more information. Feb 21 18:44:01 volumio ntpd[933]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 18:44:01 volumio ntpd[933]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Feb 21 18:44:01 volumio ntpd[933]: DNS: Pool skipping: 198.18.6.91 Feb 21 18:44:01 volumio ntpd[933]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Feb 21 18:44:01 volumio startpeppyspectrum.sh[6660]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:01 volumio startpeppyspectrum.sh[6660]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:01 volumio startpeppyspectrum.sh[6660]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:02 volumio ntpd[933]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 18:44:02 volumio ntpd[933]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Feb 21 18:44:02 volumio ntpd[933]: DNS: Pool skipping: 198.18.6.92 Feb 21 18:44:02 volumio ntpd[933]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Feb 21 18:44:03 volumio volumio[1002]: info: CoreCommandRouter::volumioStop Feb 21 18:44:03 volumio volumio[1002]: info: CoreStateMachine::stop Feb 21 18:44:03 volumio volumio[1002]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 18:44:03 volumio volumio[1002]: info: CoreStateMachine::stPlaybackTimer Feb 21 18:44:03 volumio volumio[1002]: info: CoreStateMachine::updateTrackBlock Feb 21 18:44:03 volumio volumio[1002]: info: CorePlayQueue::getTrackBlock Feb 21 18:44:03 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:44:03 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:03 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:44:03 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:44:03 volumio volumio[1002]: info: CoreStateMachine::serviceStop Feb 21 18:44:03 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:03 volumio volumio[1002]: info: CoreCommandRouter::serviceStop Feb 21 18:44:03 volumio volumio[1002]: info: [1771670643215] ControllerWebradio::stop Feb 21 18:44:03 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 18:44:03 volumio volumio[1002]: info: PeppySpectrum ---peppyspectrum status stop Feb 21 18:44:03 volumio volumio[1002]: info: sendMpdCommand stop took 36 milliseconds Feb 21 18:44:03 volumio sudo[6673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 21 18:44:03 volumio sudo[6673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:03 volumio systemd[1]: Stopping peppyspectrum.service - peppyspectrum Daemon... Feb 21 18:44:03 volumio systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 21 18:44:03 volumio systemd[1]: Stopped peppyspectrum.service - peppyspectrum Daemon. Feb 21 18:44:03 volumio systemd[1]: peppyspectrum.service: Consumed 1.864s CPU time. Feb 21 18:44:03 volumio sudo[6673]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:03 volumio volumio[1002]: info: peppyspectrum Daemon Stop Feb 21 18:44:03 volumio ntpd[933]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 18:44:03 volumio ntpd[933]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Feb 21 18:44:03 volumio ntpd[933]: DNS: Pool skipping: 198.18.6.93 Feb 21 18:44:03 volumio ntpd[933]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Feb 21 18:44:04 volumio volumio[1002]: info: CoreCommandRouter::volumioPlay Feb 21 18:44:04 volumio volumio[1002]: info: CoreStateMachine::play index undefined Feb 21 18:44:04 volumio volumio[1002]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 18:44:04 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:04 volumio volumio[1002]: info: CoreStateMachine::startPlaybackTimer Feb 21 18:44:04 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:04 volumio volumio[1002]: info: [1771670644674] ControllerWebradio::clearAddPlayTrack Feb 21 18:44:04 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 18:44:04 volumio volumio[1002]: info: sendMpdCommand stop took 1 milliseconds Feb 21 18:44:04 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 18:44:04 volumio volumio[1002]: info: Feb 21 18:44:04 volumio volumio[1002]: ---------------------------- MPD announces system playlist update Feb 21 18:44:04 volumio volumio[1002]: info: Ignoring MPD Status Update Feb 21 18:44:04 volumio volumio[1002]: info: sendMpdCommand clear took 1 milliseconds Feb 21 18:44:04 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand load "https://lhttp.qingting.fm/live/15318569/64k.mp3" Feb 21 18:44:04 volumio volumio[1002]: info: Feb 21 18:44:04 volumio volumio[1002]: ---------------------------- MPD announces system playlist update Feb 21 18:44:04 volumio volumio[1002]: info: Ignoring MPD Status Update Feb 21 18:44:04 volumio volumio[1002]: error: updateQueue error: null Feb 21 18:44:04 volumio volumio[1002]: info: ------------------------------ 3ms Feb 21 18:44:04 volumio ntpd[933]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 18:44:04 volumio ntpd[933]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Feb 21 18:44:04 volumio ntpd[933]: DNS: Pool skipping: 198.18.6.94 Feb 21 18:44:04 volumio ntpd[933]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Feb 21 18:44:05 volumio volumio[1002]: error: updateQueue error: null Feb 21 18:44:05 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand add "https://lhttp.qingting.fm/live/15318569/64k.mp3" Feb 21 18:44:05 volumio volumio[1002]: info: ------------------------------ 965ms Feb 21 18:44:05 volumio volumio[1002]: info: Feb 21 18:44:05 volumio volumio[1002]: ---------------------------- MPD announces system playlist update Feb 21 18:44:05 volumio volumio[1002]: info: Ignoring MPD Status Update Feb 21 18:44:05 volumio volumio[1002]: info: sendMpdCommand add "https://lhttp.qingting.fm/live/15318569/64k.mp3" took 1 milliseconds Feb 21 18:44:05 volumio volumio[1002]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 18:44:05 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand play Feb 21 18:44:05 volumio volumio[1002]: info: Feb 21 18:44:05 volumio volumio[1002]: ---------------------------- MPD announces system playlist update Feb 21 18:44:05 volumio volumio[1002]: info: Ignoring MPD Status Update Feb 21 18:44:05 volumio volumio[1002]: info: ------------------------------ 3ms Feb 21 18:44:05 volumio volumio[1002]: info: sendMpdCommand play took 3 milliseconds Feb 21 18:44:05 volumio volumio[1002]: info: ------------------------------ 2ms Feb 21 18:44:06 volumio volumio[1002]: info: Feb 21 18:44:06 volumio volumio[1002]: ---------------------------- MPD announces state update: player Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::getState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:44:06 volumio volumio[1002]: info: Feb 21 18:44:06 volumio volumio[1002]: ---------------------------- MPD announces state update: player Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::getState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:44:06 volumio volumio[1002]: info: Feb 21 18:44:06 volumio volumio[1002]: ---------------------------- MPD announces state update: player Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand status took 122 milliseconds Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand status took 121 milliseconds Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::getState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:44:06 volumio volumio[1002]: info: Feb 21 18:44:06 volumio volumio[1002]: ---------------------------- MPD announces state update: player Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::getState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand status Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand status took 9 milliseconds Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::servicePushState Feb 21 18:44:06 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:06 volumio volumio[1002]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"64k.mp3","artist":null,"album":null,"uri":"https://lhttp.qingting.fm/live/15318569/64k.mp3","trackType":"mp3"} Feb 21 18:44:06 volumio volumio[1002]: verbose: CURRENT POSITION 0 Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState stateService play Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState currentStatus stop Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::servicePushState Feb 21 18:44:06 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:06 volumio volumio[1002]: verbose: STATE SERVICE {"status":"play","position":0,"seek":859,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"64k.mp3","artist":null,"album":null,"uri":"https://lhttp.qingting.fm/live/15318569/64k.mp3","trackType":"mp3"} Feb 21 18:44:06 volumio volumio[1002]: verbose: CURRENT POSITION 0 Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState stateService play Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:44:06 volumio volumio[1002]: info: Received an update from plugin. extracting info from payload Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:44:06 volumio volumio[1002]: info: ------------------------------ 156ms Feb 21 18:44:06 volumio volumio[1002]: info: ------------------------------ 157ms Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand status took 29 milliseconds Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand playlistinfo took 26 milliseconds Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseState Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::servicePushState Feb 21 18:44:06 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:06 volumio volumio[1002]: verbose: STATE SERVICE {"status":"play","position":0,"seek":859,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"64k.mp3","artist":null,"album":null,"uri":"https://lhttp.qingting.fm/live/15318569/64k.mp3","trackType":"mp3"} Feb 21 18:44:06 volumio volumio[1002]: verbose: CURRENT POSITION 0 Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState stateService play Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:44:06 volumio volumio[1002]: info: Received an update from plugin. extracting info from payload Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:44:06 volumio volumio[1002]: info: ------------------------------ 58ms Feb 21 18:44:06 volumio volumio[1002]: info: PeppySpectrum ---peppyspectrum status play Feb 21 18:44:06 volumio volumio[1002]: info: PeppySpectrum ---peppyspectrum status play Feb 21 18:44:06 volumio volumio[1002]: info: PeppySpectrum ---peppyspectrum status play Feb 21 18:44:06 volumio volumio[1002]: info: PeppySpectrum ---peppyspectrum status play Feb 21 18:44:06 volumio sudo[6710]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 21 18:44:06 volumio sudo[6710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:06 volumio sudo[6712]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 21 18:44:06 volumio sudo[6712]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:06 volumio sudo[6714]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 21 18:44:06 volumio volumio[1002]: info: sendMpdCommand playlistinfo took 146 milliseconds Feb 21 18:44:06 volumio volumio[1002]: verbose: ControllerMpd::parseTrackInfo Feb 21 18:44:06 volumio volumio[1002]: info: ControllerMpd::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::servicePushState Feb 21 18:44:06 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:06 volumio volumio[1002]: verbose: STATE SERVICE {"status":"play","position":0,"seek":859,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"64k.mp3","artist":null,"album":null,"uri":"https://lhttp.qingting.fm/live/15318569/64k.mp3","trackType":"mp3"} Feb 21 18:44:06 volumio volumio[1002]: verbose: CURRENT POSITION 0 Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState stateService play Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::syncState currentStatus play Feb 21 18:44:06 volumio volumio[1002]: info: Received an update from plugin. extracting info from payload Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CorePlayQueue::getTrack 0 Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:44:06 volumio sudo[6714]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:06 volumio volumio[1002]: info: CoreStateMachine::pushState Feb 21 18:44:06 volumio volumio[1002]: info: CoreCommandRouter::volumioPushState Feb 21 18:44:06 volumio volumio[1002]: info: ------------------------------ 261ms Feb 21 18:44:06 volumio systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 21 18:44:06 volumio startpeppyspectrum.sh[6722]: sleep: invalid time interval ‘undefined’ Feb 21 18:44:06 volumio startpeppyspectrum.sh[6722]: Try 'sleep --help' for more information. Feb 21 18:44:06 volumio sudo[6710]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:06 volumio sudo[6718]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 21 18:44:06 volumio sudo[6718]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:06 volumio volumio[1002]: info: PeppySpectrum ---peppyspectrum status play Feb 21 18:44:06 volumio sudo[6714]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:06 volumio sudo[6712]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:06 volumio volumio[1002]: info: PeppySpectrum ---peppyspectrum status play Feb 21 18:44:06 volumio sudo[6718]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:07 volumio sudo[6726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 21 18:44:07 volumio sudo[6726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:07 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:07 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:07 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:07 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:07 volumio sudo[6728]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 21 18:44:07 volumio sudo[6728]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:07 volumio sudo[6726]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:07 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:07 volumio sudo[6728]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:07 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:08 volumio startpeppyspectrum.sh[6723]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:08 volumio startpeppyspectrum.sh[6723]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:08 volumio startpeppyspectrum.sh[6723]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:18 volumio volumio[1002]: info: CALLMETHOD: user_interface peppyspectrum delayspectrum [object Object] Feb 21 18:44:18 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , delayspectrum Feb 21 18:44:18 volumio volumio[1002]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 21 18:44:18 volumio volumio[1002]: info: PeppySpectrum -----------------------spectrums.2 Feb 21 18:44:18 volumio volumio[1002]: info: PeppySpectrum -----------------------$basefolder Feb 21 18:44:18 volumio volumio[1002]: info: PeppySpectrum -----------------------screensize1280x400 Feb 21 18:44:18 volumio volumio[1002]: info: PeppySpectrum -----------------------screenwidth Feb 21 18:44:18 volumio volumio[1002]: info: PeppySpectrum -----------------------screenheight Feb 21 18:44:18 volumio volumio[1002]: info: PeppySpectrum -----------------------spectrumsize30 Feb 21 18:44:18 volumio volumio[1002]: error: PeppySpectrum ---Error writing config null Feb 21 18:44:18 volumio sudo[6764]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart peppyspectrum.service Feb 21 18:44:18 volumio sudo[6764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 18:44:18 volumio systemd[1]: Stopping peppyspectrum.service - peppyspectrum Daemon... Feb 21 18:44:18 volumio volumio[1002]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:44:18 volumio volumio[1002]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:44:18 volumio systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 21 18:44:19 volumio systemd[1]: Stopped peppyspectrum.service - peppyspectrum Daemon. Feb 21 18:44:19 volumio systemd[1]: peppyspectrum.service: Consumed 3.270s CPU time. Feb 21 18:44:19 volumio systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 21 18:44:19 volumio sudo[6764]: pam_unix(sudo:session): session closed for user root Feb 21 18:44:19 volumio volumio[1002]: info: peppyspectrum Daemon Started Feb 21 18:44:19 volumio startpeppyspectrum.sh[6768]: sleep: invalid time interval ‘undefined’ Feb 21 18:44:19 volumio startpeppyspectrum.sh[6768]: Try 'sleep --help' for more information. Feb 21 18:44:20 volumio startpeppyspectrum.sh[6769]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:20 volumio startpeppyspectrum.sh[6769]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:20 volumio startpeppyspectrum.sh[6769]: libpng warning: iCCP: known incorrect sRGB profile Feb 21 18:44:22 volumio volumio[1002]: info: CALLMETHOD: user_interface peppyspectrum updatelist Feb 21 18:44:22 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , updatelist Feb 21 18:44:22 volumio volumio[1002]: info: PeppySpectrum --- wget 'https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt' Feb 21 18:44:23 volumio volumio[1002]: --2026-02-21 18:44:22-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt Feb 21 18:44:23 volumio volumio[1002]: Resolving github.com (github.com)... 198.18.0.70 Feb 21 18:44:23 volumio volumio[1002]: Connecting to github.com (github.com)|198.18.0.70|:443... connected. Feb 21 18:44:23 volumio volumio[1002]: HTTP request sent, awaiting response... 302 Found Feb 21 18:44:23 volumio volumio[1002]: Location: https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt [following] Feb 21 18:44:23 volumio volumio[1002]: --2026-02-21 18:44:22-- https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt Feb 21 18:44:23 volumio volumio[1002]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 198.18.0.72 Feb 21 18:44:23 volumio volumio[1002]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|198.18.0.72|:443... connected. Feb 21 18:44:23 volumio volumio[1002]: HTTP request sent, awaiting response... 200 OK Feb 21 18:44:23 volumio volumio[1002]: Length: 471 [text/plain] Feb 21 18:44:23 volumio volumio[1002]: Saving to: ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ Feb 21 18:44:23 volumio volumio[1002]: 0K 100% 8.46M=0s Feb 21 18:44:23 volumio volumio[1002]: 2026-02-21 18:44:23 (8.46 MB/s) - ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ saved [471/471] Feb 21 18:44:23 volumio volumio[1002]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 21 18:44:23 volumio volumio[1002]: info: CoreCommandRouter::Close All Modals sent Feb 21 18:44:38 volumio volumio[1002]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object] Feb 21 18:44:38 volumio volumio[1002]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum Feb 21 18:44:40 volumio volumio[1002]: --2026-02-21 18:44:38-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Feb 21 18:44:40 volumio volumio[1002]: Resolving github.com (github.com)... 198.18.0.70 Feb 21 18:44:40 volumio volumio[1002]: Connecting to github.com (github.com)|198.18.0.70|:443... connected. Feb 21 18:44:40 volumio volumio[1002]: HTTP request sent, awaiting response... 404 Not Found Feb 21 18:44:40 volumio volumio[1002]: 2026-02-21 18:44:39 ERROR 404: Not Found. Feb 21 18:44:40 volumio volumio[1002]: --2026-02-21 18:44:39-- http://a/ Feb 21 18:44:40 volumio volumio[1002]: Resolving a (a)... failed: Device or resource busy. Feb 21 18:44:40 volumio volumio[1002]: wget: unable to resolve host address ‘a’ Feb 21 18:44:40 volumio volumio[1002]: --2026-02-21 18:44:39-- http://packet.zip/ Feb 21 18:44:40 volumio volumio[1002]: Resolving packet.zip (packet.zip)... 198.18.6.151 Feb 21 18:44:40 volumio volumio[1002]: Connecting to packet.zip (packet.zip)|198.18.6.151|:80... connected. Feb 21 18:44:40 volumio volumio[1002]: HTTP request sent, awaiting response... 302 Found Feb 21 18:44:40 volumio volumio[1002]: Location: http://www.packet.zip/ [following] Feb 21 18:44:40 volumio volumio[1002]: --2026-02-21 18:44:39-- http://www.packet.zip/ Feb 21 18:44:40 volumio volumio[1002]: Resolving www.packet.zip (www.packet.zip)... 198.18.6.152 Feb 21 18:44:40 volumio volumio[1002]: Connecting to www.packet.zip (www.packet.zip)|198.18.6.152|:80... connected. Feb 21 18:44:40 volumio volumio[1002]: HTTP request sent, awaiting response... 403 Forbidden Feb 21 18:44:40 volumio volumio[1002]: 2026-02-21 18:44:40 ERROR 403: Forbidden. Feb 21 18:44:40 volumio volumio[1002]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Feb 21 18:44:40 volumio volumio[1002]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 21 18:44:40 volumio volumio[1002]: /bin/rm: cannot remove 'a': No such file or directory Feb 21 18:44:40 volumio volumio[1002]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 21 18:44:40 volumio volumio[1002]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 18:44:40 volumio volumio[1002]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Feb 21 18:44:40 volumio volumio[1002]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 21 18:44:40 volumio volumio[1002]: /bin/rm: cannot remove 'a': No such file or directory Feb 21 18:44:40 volumio volumio[1002]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 21 18:44:40 volumio volumio[1002]: at checkExecSyncError (node:child_process:887:11) Feb 21 18:44:40 volumio volumio[1002]: at execSync (node:child_process:959:15) Feb 21 18:44:40 volumio volumio[1002]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19 Feb 21 18:44:40 volumio volumio[1002]: at new Promise () Feb 21 18:44:40 volumio volumio[1002]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12) Feb 21 18:44:40 volumio volumio[1002]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Feb 21 18:44:40 volumio volumio[1002]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Feb 21 18:44:40 volumio volumio[1002]: at Socket.emit (node:events:514:28) Feb 21 18:44:40 volumio volumio[1002]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 21 18:44:40 volumio volumio[1002]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Feb 21 18:44:40 volumio volumio[1002]: status: 1, Feb 21 18:44:40 volumio volumio[1002]: signal: null, Feb 21 18:44:40 volumio volumio[1002]: output: [ Feb 21 18:44:40 volumio volumio[1002]: null, Feb 21 18:44:40 volumio volumio[1002]: , Feb 21 18:44:40 volumio volumio[1002]: Feb 21 18:44:40 volumio volumio[1002]: ], Feb 21 18:44:40 volumio volumio[1002]: pid: 6833, Feb 21 18:44:40 volumio volumio[1002]: stdout: , Feb 21 18:44:40 volumio volumio[1002]: stderr: Feb 21 18:44:40 volumio volumio[1002]: } Feb 21 18:44:40 volumio volumio[1002]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 18:44:40 volumio sudo[6849]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-21 18:43' Feb 21 18:44:40 volumio sudo[6849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"