-- Logs begin at Thu 2019-02-14 12:11:59 EET, end at Sat 2026-03-28 05:53:21 EET. -- Mar 28 05:52:00 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 05:52:00 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 28 05:52:06 volumio volumio[1257]: info: Enabling plugin touch_display Mar 28 05:52:06 volumio volumio[1257]: info: Loading plugin "touch_display"... Mar 28 05:52:06 volumio volumio[1257]: info: Applying required configuration parameters for plugin touch_display Mar 28 05:52:06 volumio volumio[1257]: info: PLUGIN START: touch_display Mar 28 05:52:06 volumio volumio[1257]: info: Loading i18n strings for locale en Mar 28 05:52:06 volumio volumio[1257]: info: Plugin peppymeterbasic has duplicated i18n key SAVE. It is ignored. Mar 28 05:52:06 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 05:52:06 volumio sudo[5553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Mar 28 05:52:06 volumio sudo[5553]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 05:52:06 volumio sudo[5556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Mar 28 05:52:06 volumio sudo[5556]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 05:52:06 volumio volumio[1257]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Mar 28 05:52:06 volumio sudo[5559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 28 05:52:06 volumio sudo[5559]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 05:52:06 volumio systemd[1]: Reloading. Mar 28 05:52:06 volumio volumio[1257]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Mar 28 05:52:06 volumio sudo[5562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Mar 28 05:52:06 volumio sudo[5562]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 05:52:06 volumio sudo[5562]: pam_unix(sudo:session): session closed for user root Mar 28 05:52:06 volumio volumio[1257]: error: touch_display: Error setting file permissions for /etc/X11/xorg.conf.d/99-vc4.conf: Error: Command failed: /usr/bin/sudo /bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Mar 28 05:52:06 volumio volumio[1257]: /bin/chmod: cannot access '/etc/X11/xorg.conf.d/99-vc4.conf': No such file or directory Mar 28 05:52:06 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 28 05:52:07 volumio sudo[5556]: pam_unix(sudo:session): session closed for user root Mar 28 05:52:07 volumio volumio[1257]: info: touch_display: systemctl disable getty@tty1.service succeeded. Mar 28 05:52:07 volumio systemd[1]: Reloading. Mar 28 05:52:07 volumio sudo[5553]: pam_unix(sudo:session): session closed for user root Mar 28 05:52:07 volumio volumio[1257]: info: touch_display: systemctl stop getty@tty1.service succeeded. Mar 28 05:52:07 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 28 05:52:08 volumio sudo[5559]: pam_unix(sudo:session): session closed for user root Mar 28 05:52:08 volumio volumio[1257]: info: touch_display: systemctl daemon-reload succeeded. Mar 28 05:52:08 volumio sudo[5593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Mar 28 05:52:08 volumio sudo[5593]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 05:52:08 volumio sudo[5593]: pam_unix(sudo:session): session closed for user root Mar 28 05:52:08 volumio volumio[1257]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Mar 28 05:52:08 volumio volumio[1257]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Mar 28 05:52:08 volumio volumio[1257]: info: Error: Error Mar 28 05:52:25 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 05:52:25 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 28 05:52:29 volumio go-librespot[1661]: time="2026-03-28T05:52:29+02:00" level=trace msg="sent dealer ping" Mar 28 05:52:29 volumio go-librespot[1661]: time="2026-03-28T05:52:29+02:00" level=trace msg="received dealer pong" Mar 28 05:52:36 volumio volumio[1257]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 05:52:59 volumio go-librespot[1661]: time="2026-03-28T05:52:59+02:00" level=trace msg="sent dealer ping" Mar 28 05:52:59 volumio go-librespot[1661]: time="2026-03-28T05:52:59+02:00" level=trace msg="received dealer pong" Mar 28 05:52:59 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 05:52:59 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 28 05:53:08 volumio volumio[1257]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---list is random,fluo-blue-linear,fluo-green-linear,blue-circ,orange-circ,green-circ Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---800x480-test Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---800x480-balbuze Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1024x600-Gelo5-BASIC_121 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1280x400-Gelo5-BASIC_221 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1280x800-Gelo5-BASIC_421 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1480x320-Gelo5-BASIC_521 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1600x720-balbuze Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1920x480-Gelo5-BASIC_521 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1920x515-Gelo5-BASIC_921 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1920x720-balbuze Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1920x720-Gelo5-BASIC_721 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1920x1080-Gelo5-BASIC_721 Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---1920x1080-balbuze Mar 28 05:53:08 volumio volumio[1257]: info: PeppyMeterBasic ---2560x720-Gelo5-BASIC_921 Mar 28 05:53:16 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 05:53:16 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 28 05:53:18 volumio volumio[1257]: info: CoreCommandRouter::volumioPlay Mar 28 05:53:18 volumio volumio[1257]: info: CoreStateMachine::play index undefined Mar 28 05:53:18 volumio volumio[1257]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 28 05:53:18 volumio volumio[1257]: info: CorePlayQueue::getTrack 0 Mar 28 05:53:18 volumio volumio[1257]: info: CoreStateMachine::startPlaybackTimer Mar 28 05:53:18 volumio volumio[1257]: info: CorePlayQueue::getTrack 0 Mar 28 05:53:18 volumio volumio[1257]: info: [1774669998211] ControllerWebradio::clearAddPlayTrack Mar 28 05:53:18 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand stop Mar 28 05:53:18 volumio volumio[1257]: info: sendMpdCommand stop took 8 milliseconds Mar 28 05:53:18 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand clear Mar 28 05:53:18 volumio volumio[1257]: info: Mar 28 05:53:18 volumio volumio[1257]: ---------------------------- MPD announces system playlist update Mar 28 05:53:18 volumio volumio[1257]: info: Ignoring MPD Status Update Mar 28 05:53:18 volumio volumio[1257]: info: sendMpdCommand clear took 6 milliseconds Mar 28 05:53:18 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8360/flac.flac" Mar 28 05:53:18 volumio volumio[1257]: error: updateQueue error: null Mar 28 05:53:18 volumio volumio[1257]: info: ------------------------------ 12ms Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac" Mar 28 05:53:20 volumio volumio[1257]: info: Mar 28 05:53:20 volumio volumio[1257]: ---------------------------- MPD announces system playlist update Mar 28 05:53:20 volumio volumio[1257]: info: Ignoring MPD Status Update Mar 28 05:53:20 volumio volumio[1257]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac" took 2 milliseconds Mar 28 05:53:20 volumio volumio[1257]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand play Mar 28 05:53:20 volumio volumio[1257]: info: ------------------------------ 5ms Mar 28 05:53:20 volumio volumio[1257]: info: sendMpdCommand play took 4 milliseconds Mar 28 05:53:20 volumio volumio[1257]: info: Mar 28 05:53:20 volumio volumio[1257]: ---------------------------- MPD announces state update: player Mar 28 05:53:20 volumio volumio[1257]: info: ControllerMpd::getState Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand status Mar 28 05:53:20 volumio volumio[1257]: info: Mar 28 05:53:20 volumio volumio[1257]: ---------------------------- MPD announces state update: player Mar 28 05:53:20 volumio volumio[1257]: info: sendMpdCommand status took 49 milliseconds Mar 28 05:53:20 volumio volumio[1257]: info: ControllerMpd::getState Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand status Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::parseState Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 05:53:20 volumio volumio[1257]: info: sendMpdCommand status took 5 milliseconds Mar 28 05:53:20 volumio volumio[1257]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::parseState Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::parseTrackInfo Mar 28 05:53:20 volumio volumio[1257]: info: ControllerMpd::pushState Mar 28 05:53:20 volumio volumio[1257]: info: CoreCommandRouter::servicePushState Mar 28 05:53:20 volumio volumio[1257]: info: CorePlayQueue::getTrack 0 Mar 28 05:53:20 volumio volumio[1257]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"} Mar 28 05:53:20 volumio volumio[1257]: verbose: CURRENT POSITION 0 Mar 28 05:53:20 volumio volumio[1257]: info: CoreStateMachine::syncState stateService play Mar 28 05:53:20 volumio volumio[1257]: info: CoreStateMachine::syncState currentStatus stop Mar 28 05:53:20 volumio volumio[1257]: info: ------------------------------ 68ms Mar 28 05:53:20 volumio volumio[1257]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 28 05:53:20 volumio volumio[1257]: verbose: ControllerMpd::parseTrackInfo Mar 28 05:53:20 volumio volumio[1257]: info: ControllerMpd::pushState Mar 28 05:53:20 volumio volumio[1257]: info: CoreCommandRouter::servicePushState Mar 28 05:53:20 volumio volumio[1257]: info: CorePlayQueue::getTrack 0 Mar 28 05:53:20 volumio volumio[1257]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"} Mar 28 05:53:20 volumio volumio[1257]: verbose: CURRENT POSITION 0 Mar 28 05:53:20 volumio volumio[1257]: info: CoreStateMachine::syncState stateService play Mar 28 05:53:20 volumio volumio[1257]: info: CoreStateMachine::syncState currentStatus play Mar 28 05:53:20 volumio volumio[1257]: info: Received an update from plugin. extracting info from payload Mar 28 05:53:20 volumio volumio[1257]: info: CoreStateMachine::pushState Mar 28 05:53:20 volumio volumio[1257]: info: CorePlayQueue::getTrack 0 Mar 28 05:53:20 volumio volumio[1257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 28 05:53:20 volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Mar 28 05:53:20 volumio volumio[1257]: info: CoreStateMachine::pushState Mar 28 05:53:20 volumio volumio[1257]: info: CoreCommandRouter::volumioPushState Mar 28 05:53:20 volumio volumio5-onboarding[1512]: time=2026-03-28T05:53:20.790+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.230:51688 @ 0x294bdd0" state=STATUS_PLAYING positionMs=0 volume=100 Mar 28 05:53:20 volumio volumio5-onboarding[1512]: time=2026-03-28T05:53:20.791+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.230:51688 @ 0x294bdd0" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)" Mar 28 05:53:20 volumio volumio5-onboarding[1512]: time=2026-03-28T05:53:20.796+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.230:51688 @ 0x294bdd0" state=STATUS_PLAYING positionMs=0 volume=100 Mar 28 05:53:20 volumio volumio5-onboarding[1512]: time=2026-03-28T05:53:20.797+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.230:51688 @ 0x294bdd0" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)" Mar 28 05:53:20 volumio volumio[1257]: info: ------------------------------ 72ms Mar 28 05:53:20 volumio volumio[1257]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 28 05:53:20 volumio volumio[1257]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 28 05:53:20 volumio sudo[5759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 28 05:53:20 volumio sudo[5759]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 05:53:20 volumio volumio[1257]: info: [ASDebug] CurState: play PrevState: stop Mar 28 05:53:20 volumio volumio[1257]: info: [ASDebug] Togle GPIO: ON Mar 28 05:53:20 volumio volumio[1257]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 05:53:20 volumio volumio[1257]: Error: ESPIPE: invalid seek, write Mar 28 05:53:20 volumio volumio[1257]: at Object.writeSync (fs.js:711:3) Mar 28 05:53:20 volumio volumio[1257]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Mar 28 05:53:20 volumio volumio[1257]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:207:23) Mar 28 05:53:20 volumio volumio[1257]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:190:86) Mar 28 05:53:20 volumio volumio[1257]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Mar 28 05:53:20 volumio volumio[1257]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10) Mar 28 05:53:20 volumio volumio[1257]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12) Mar 28 05:53:20 volumio volumio[1257]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Mar 28 05:53:20 volumio volumio[1257]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Mar 28 05:53:20 volumio volumio[1257]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8) Mar 28 05:53:20 volumio volumio[1257]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Mar 28 05:53:20 volumio volumio[1257]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Mar 28 05:53:20 volumio volumio[1257]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:254:12) Mar 28 05:53:20 volumio volumio[1257]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16) Mar 28 05:53:20 volumio volumio[1257]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Mar 28 05:53:20 volumio volumio[1257]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) { Mar 28 05:53:20 volumio volumio[1257]: errno: -29, Mar 28 05:53:20 volumio volumio[1257]: syscall: 'write', Mar 28 05:53:20 volumio volumio[1257]: code: 'ESPIPE' Mar 28 05:53:20 volumio volumio[1257]: } Mar 28 05:53:20 volumio volumio[1257]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 05:53:20 volumio sudo[5762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 28 05:53:20 volumio sudo[5762]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 05:53:21 volumio systemd[1]: Started peppymeterbasic Daemon. Mar 28 05:53:21 volumio sudo[5759]: pam_unix(sudo:session): session closed for user root Mar 28 05:53:21 volumio sudo[5762]: pam_unix(sudo:session): session closed for user root Mar 28 05:53:21 volumio sudo[5816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-28 05:52 Mar 28 05:53:21 volumio sudo[5816]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"