Dec 15 09:10:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:20 volumio volumio[1149]: info: Prefetching next song Dec 15 09:10:20 volumio volumio[1149]: info: DOING PREFETCH IN MPD Dec 15 09:10:20 volumio volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/B028C6C328C687B4/BravoHitsVol01122MP3/2014 Vol. 87 2CD/CD2/19. 257ers - Baby Du Riechst.mp3" Dec 15 09:10:20 volumio volumio[1149]: info: Dec 15 09:10:20 volumio volumio[1149]: ---------------------------- MPD announces system playlist update Dec 15 09:10:20 volumio volumio[1149]: info: Ignoring MPD Status Update Dec 15 09:10:20 volumio volumio[1149]: info: sendMpdCommand add "USB/B028C6C328C687B4/BravoHitsVol01122MP3/2014 Vol. 87 2CD/CD2/19. 257ers - Baby Du Riechst.mp3" took 2 milliseconds Dec 15 09:10:20 volumio volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 15 09:10:20 volumio volumio[1149]: info: ------------------------------ 2ms Dec 15 09:10:20 volumio volumio[1149]: info: Dec 15 09:10:20 volumio volumio[1149]: ---------------------------- MPD announces state update: options Dec 15 09:10:20 volumio volumio[1149]: info: sendMpdCommand consume 1 took 2 milliseconds Dec 15 09:10:20 volumio volumio[1149]: info: ControllerMpd::getState Dec 15 09:10:20 volumio volumio[1149]: verbose: ControllerMpd::sendMpdCommand status Dec 15 09:10:20 volumio volumio[1149]: info: sendMpdCommand status took 0 milliseconds Dec 15 09:10:20 volumio volumio[1149]: verbose: ControllerMpd::parseState Dec 15 09:10:20 volumio volumio[1149]: info: ControllerMpd::pushState Dec 15 09:10:20 volumio volumio[1149]: info: CoreCommandRouter::servicePushState Dec 15 09:10:20 volumio volumio[1149]: info: CoreStateMachine::pushState Dec 15 09:10:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:20 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 09:10:20 volumio volumio[1149]: info: CoreCommandRouter::volumioPushState Dec 15 09:10:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:20 volumio volumio[1149]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 15 09:10:20 volumio volumio[1149]: verbose: CURRENT POSITION 0 Dec 15 09:10:20 volumio volumio[1149]: info: CoreStateMachine::syncState stateService stop Dec 15 09:10:20 volumio volumio[1149]: info: CoreStateMachine::syncState currentStatus stop Dec 15 09:10:20 volumio volumio[1149]: info: CoreStateMachine::pushState Dec 15 09:10:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:20 volumio volumio[1149]: info: CoreCommandRouter::volumioPushState Dec 15 09:10:20 volumio volumio[1149]: info: No code Dec 15 09:10:20 volumio volumio[1149]: info: CoreStateMachine::pushState Dec 15 09:10:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:20 volumio volumio[1149]: info: CoreCommandRouter::volumioPushState Dec 15 09:10:20 volumio volumio[1149]: info: ------------------------------ 42ms Dec 15 09:10:20 volumio volumio[1149]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 15 09:10:20 volumio volumio[1149]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 15 09:10:20 volumio volumio[1149]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 15 09:10:20 volumio sudo[8062]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 15 09:10:20 volumio sudo[8062]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:10:20 volumio sudo[8064]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 15 09:10:20 volumio sudo[8064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:10:20 volumio sudo[8067]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 15 09:10:20 volumio sudo[8067]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: SPOTIFY VOLUME 86 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: VOLUMIO VOLUME 85 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: SPOTIFY VOLUME 86 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: VOLUMIO VOLUME 85 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: SPOTIFY VOLUME 86 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: VOLUMIO VOLUME 85 Dec 15 09:10:20 volumio volumio[1149]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 09:10:20 volumio sudo[8064]: pam_unix(sudo:session): session closed for user root Dec 15 09:10:20 volumio sudo[8062]: pam_unix(sudo:session): session closed for user root Dec 15 09:10:20 volumio volumio[1149]: info: peppymeterbasic Daemon Stop Dec 15 09:10:20 volumio volumio[1149]: info: peppymeterbasic Daemon Stop Dec 15 09:10:20 volumio sudo[8067]: pam_unix(sudo:session): session closed for user root Dec 15 09:10:20 volumio volumio[1149]: info: peppymeterbasic Daemon Stop Dec 15 09:10:23 volumio go-librespot[2141]: time="2025-12-15T09:10:23+01:00" level=trace msg="received accesspoint ping" Dec 15 09:10:23 volumio go-librespot[2141]: time="2025-12-15T09:10:23+01:00" level=trace msg="received accesspoint pong ack" Dec 15 09:10:23 volumio go-librespot[2141]: time="2025-12-15T09:10:23+01:00" level=trace msg="sent dealer ping" Dec 15 09:10:24 volumio go-librespot[2141]: time="2025-12-15T09:10:24+01:00" level=trace msg="received dealer pong" Dec 15 09:10:24 volumio volumio[1149]: info: CoreStateMachine::startPlaybackTimer Dec 15 09:10:24 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:25 volumio volumio[1149]: info: CoreStateMachine::pushState Dec 15 09:10:25 volumio volumio[1149]: info: CorePlayQueue::getTrack 0 Dec 15 09:10:25 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 09:10:25 volumio volumio[1149]: info: CoreCommandRouter::volumioPushState Dec 15 09:10:25 volumio volumio[1149]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 15 09:10:25 volumio volumio[1149]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Dec 15 09:10:25 volumio volumio[1149]: SPOTIFY: SPOTIFY VOLUME 86 Dec 15 09:10:25 volumio volumio[1149]: SPOTIFY: VOLUMIO VOLUME 85 Dec 15 09:10:25 volumio volumio[1149]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 15 09:10:25 volumio sudo[8071]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 15 09:10:25 volumio sudo[8071]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 15 09:10:25 volumio sudo[8071]: pam_unix(sudo:session): session closed for user root Dec 15 09:10:25 volumio volumio[1149]: info: peppymeterbasic Daemon Stop Dec 15 09:10:49 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 15 09:10:49 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 15 09:10:53 volumio go-librespot[2141]: time="2025-12-15T09:10:53+01:00" level=trace msg="sent dealer ping" Dec 15 09:10:53 volumio go-librespot[2141]: time="2025-12-15T09:10:53+01:00" level=trace msg="received dealer pong" Dec 15 09:11:09 volumio volumio[1149]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 15 09:11:18 volumio volumio[1149]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Dec 15 09:11:18 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Dec 15 09:11:18 volumio volumio[1149]: aaaaaaaaaaa 1280,400 Dec 15 09:11:18 volumio volumio[1149]: info: PeppyMeterBasic ---1280400 Dec 15 09:11:18 volumio volumio[1149]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 15 09:11:18 volumio volumio[1149]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 15 09:11:19 volumio volumio[1149]: info: CoreCommandRouter::Close All Modals sent Dec 15 09:11:20 volumio volumio[1149]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Dec 15 09:11:20 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Dec 15 09:11:20 volumio volumio[1149]: aaaaaaaaaaa 1280,400 Dec 15 09:11:20 volumio volumio[1149]: info: PeppyMeterBasic ---1280400 Dec 15 09:11:20 volumio volumio[1149]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 15 09:11:20 volumio volumio[1149]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 15 09:11:20 volumio volumio[1149]: info: CoreCommandRouter::Close All Modals sent Dec 15 09:11:23 volumio go-librespot[2141]: time="2025-12-15T09:11:23+01:00" level=trace msg="sent dealer ping" Dec 15 09:11:24 volumio go-librespot[2141]: time="2025-12-15T09:11:24+01:00" level=trace msg="received dealer pong" Dec 15 09:11:44 volumio volumio[1149]: info: CALLMETHOD: user_interface peppymeterbasic dlmeter [object Object] Dec 15 09:11:44 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , dlmeter Dec 15 09:11:46 volumio volumio[1149]: --2025-12-15 09:11:45-- https://github.com/balbuze/Meter-peppymeter/raw/main/Zipped-folders/Choose Dec 15 09:11:46 volumio volumio[1149]: Resolving github.com (github.com)... 140.82.121.4 Dec 15 09:11:46 volumio volumio[1149]: Connecting to github.com (github.com)|140.82.121.4|:443... connected. Dec 15 09:11:46 volumio volumio[1149]: HTTP request sent, awaiting response... 404 Not Found Dec 15 09:11:46 volumio volumio[1149]: 2025-12-15 09:11:45 ERROR 404: Not Found. Dec 15 09:11:46 volumio volumio[1149]: --2025-12-15 09:11:45-- http://a/ Dec 15 09:11:46 volumio volumio[1149]: Resolving a (a)... failed: Device or resource busy. Dec 15 09:11:46 volumio volumio[1149]: wget: unable to resolve host address ‘a’ Dec 15 09:11:46 volumio volumio[1149]: --2025-12-15 09:11:45-- http://packet.zip/ Dec 15 09:11:46 volumio volumio[1149]: Resolving packet.zip (packet.zip)... 162.255.119.167 Dec 15 09:11:46 volumio volumio[1149]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Dec 15 09:11:46 volumio volumio[1149]: HTTP request sent, awaiting response... 302 Found Dec 15 09:11:46 volumio volumio[1149]: Location: http://www.packet.zip/ [following] Dec 15 09:11:46 volumio volumio[1149]: --2025-12-15 09:11:46-- http://www.packet.zip/ Dec 15 09:11:46 volumio volumio[1149]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Dec 15 09:11:46 volumio volumio[1149]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Dec 15 09:11:46 volumio volumio[1149]: HTTP request sent, awaiting response... 403 Forbidden Dec 15 09:11:46 volumio volumio[1149]: 2025-12-15 09:11:46 ERROR 403: Forbidden. Dec 15 09:11:46 volumio volumio[1149]: error: PeppyMeterBasic --- An error occurs while downloading or installing Meters Dec 15 09:11:46 volumio volumio[1149]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 15 09:11:46 volumio volumio[1149]: /bin/rm: cannot remove 'a': No such file or directory Dec 15 09:11:46 volumio volumio[1149]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 15 09:11:46 volumio volumio[1149]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 09:11:46 volumio volumio[1149]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Dec 15 09:11:46 volumio volumio[1149]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 15 09:11:46 volumio volumio[1149]: /bin/rm: cannot remove 'a': No such file or directory Dec 15 09:11:46 volumio volumio[1149]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 15 09:11:46 volumio volumio[1149]: at checkExecSyncError (node:child_process:887:11) Dec 15 09:11:46 volumio volumio[1149]: at execSync (node:child_process:959:15) Dec 15 09:11:46 volumio volumio[1149]: at /data/plugins/user_interface/peppymeterbasic/index.js:710:19 Dec 15 09:11:46 volumio volumio[1149]: at new Promise () Dec 15 09:11:46 volumio volumio[1149]: at peppymeterbasic.dlmeter (/data/plugins/user_interface/peppymeterbasic/index.js:685:12) Dec 15 09:11:46 volumio volumio[1149]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 15 09:11:46 volumio volumio[1149]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Dec 15 09:11:46 volumio volumio[1149]: at Socket.emit (node:events:514:28) Dec 15 09:11:46 volumio volumio[1149]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 15 09:11:46 volumio volumio[1149]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Dec 15 09:11:46 volumio volumio[1149]: status: 1, Dec 15 09:11:46 volumio volumio[1149]: signal: null, Dec 15 09:11:46 volumio volumio[1149]: output: [ Dec 15 09:11:46 volumio volumio[1149]: null, Dec 15 09:11:46 volumio volumio[1149]: , Dec 15 09:11:46 volumio volumio[1149]: Dec 15 09:11:46 volumio volumio[1149]: ], Dec 15 09:11:46 volumio volumio[1149]: pid: 8212, Dec 15 09:11:46 volumio volumio[1149]: stdout: , Dec 15 09:11:46 volumio volumio[1149]: stderr: Dec 15 09:11:46 volumio volumio[1149]: } Dec 15 09:11:46 volumio volumio[1149]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 09:11:46 volumio sudo[8229]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-15 09:10' Dec 15 09:11:46 volumio sudo[8229]: 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"