-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-03-02 06:33:50 CET. -- Mar 02 06:32:23 volumio3 volumio[926]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 02 06:32:23 volumio3 volumio[926]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 02 06:32:23 volumio3 volumio[926]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 02 06:32:23 volumio3 volumio[926]: info: FusionDsp - Mar 02 06:32:23 volumio3 volumio[926]: info: FusionDsp - undefined Mar 02 06:32:28 volumio3 volumio[926]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 02 06:32:53 volumio3 volumio[926]: info: Enabling plugin spop Mar 02 06:32:53 volumio3 volumio[926]: info: Loading plugin "spop"... Mar 02 06:32:53 volumio3 volumio[926]: info: PLUGIN START: spop Mar 02 06:32:53 volumio3 volumio[926]: info: Creating Spotify config file Mar 02 06:32:53 volumio3 volumio[926]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 06:32:53 volumio3 volumio[926]: info: Done. Mar 02 06:32:53 volumio3 volumio[926]: info: No need to fix Spotify hosts Mar 02 06:32:53 volumio3 volumio[926]: info: Spotify config file written Mar 02 06:32:53 volumio3 volumio[926]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 02 06:32:53 volumio3 volumio[926]: info: FusionDsp - Mar 02 06:32:53 volumio3 sudo[7513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 02 06:32:53 volumio3 sudo[7513]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:32:53 volumio3 systemd[1]: Stopping go-librespot Daemon... Mar 02 06:32:53 volumio3 systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Mar 02 06:32:54 volumio3 systemd[1]: go-librespot-daemon.service: Succeeded. Mar 02 06:32:54 volumio3 systemd[1]: Stopped go-librespot Daemon. Mar 02 06:32:54 volumio3 systemd[1]: Started go-librespot Daemon. Mar 02 06:32:54 volumio3 go-librespot[7516]: go-librespot daemon starting... Mar 02 06:32:54 volumio3 sudo[7513]: pam_unix(sudo:session): session closed for user root Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=info msg="running go-librespot 0.2.0" Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=debug msg="app state loaded" Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=debug msg="stored credentials not found" Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 02 06:32:54 volumio3 volumio[926]: info: FusionDsp - undefined Mar 02 06:32:54 volumio3 volumio[926]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 02 06:32:54 volumio3 volumio[926]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 02 06:32:54 volumio3 volumio[926]: info: Connection to go-librespot Websocket closed Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 02 06:32:54 volumio3 go-librespot[7516]: time="2025-03-02T06:32:54+01:00" level=info msg="zeroconf server listening on port 45205" Mar 02 06:32:57 volumio3 volumio[926]: info: go-librespot daemon successfully initialized Mar 02 06:32:57 volumio3 volumio[926]: info: Initializing connection to go-librespot Websocket Mar 02 06:32:57 volumio3 go-librespot[7516]: time="2025-03-02T06:32:57+01:00" level=debug msg="new websocket client" Mar 02 06:32:57 volumio3 volumio[926]: info: Connection to go-librespot Websocket established Mar 02 06:33:00 volumio3 volumio[926]: info: Initializing connection to go-librespot Websocket Mar 02 06:33:00 volumio3 go-librespot[7516]: time="2025-03-02T06:33:00+01:00" level=debug msg="new websocket client" Mar 02 06:33:00 volumio3 volumio[926]: info: Connection to go-librespot Websocket established Mar 02 06:33:00 volumio3 volumio[926]: info: Getting Spotify volume Mar 02 06:33:00 volumio3 volumio[926]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 02 06:33:00 volumio3 volumio[926]: info: CoreCommandRouter::volumioGetState Mar 02 06:33:00 volumio3 volumio[926]: info: CorePlayQueue::getTrack 0 Mar 02 06:33:03 volumio3 volumio[926]: info: Getting Spotify volume Mar 02 06:33:03 volumio3 volumio[926]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 02 06:33:03 volumio3 volumio[926]: info: CoreCommandRouter::volumioGetState Mar 02 06:33:03 volumio3 volumio[926]: info: CorePlayQueue::getTrack 0 Mar 02 06:33:07 volumio3 volumio[926]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 02 06:33:18 volumio3 volumio[926]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf Mar 02 06:33:20 volumio3 volumio[926]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf Mar 02 06:33:20 volumio3 volumio[926]: info: Folder /tmp/plugins removed Mar 02 06:33:20 volumio3 volumio[926]: info: Check plugin dependencies Mar 02 06:33:20 volumio3 volumio[926]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 02 06:33:20 volumio3 volumio[926]: info: Checking if plugin already exists Mar 02 06:33:20 volumio3 volumio[926]: info: Rename folder Mar 02 06:33:20 volumio3 volumio[926]: info: Folder /tmp/downloaded_plugin.zip removed Mar 02 06:33:20 volumio3 volumio[926]: info: Move to category Mar 02 06:33:21 volumio3 volumio[926]: info: Checking if install.sh is present Mar 02 06:33:21 volumio3 volumio[926]: info: Executing install.sh Mar 02 06:33:21 volumio3 sudo[7591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/mpd_oled/install.sh Mar 02 06:33:21 volumio3 sudo[7591]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:21 volumio3 sudo[7594]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/bash mpd_oled_volumio_install_latest.sh Mar 02 06:33:21 volumio3 sudo[7594]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:22 volumio3 volumio[926]: info: Hit:1 http://raspbian.raspberrypi.org/raspbian buster InRelease Mar 02 06:33:22 volumio3 volumio[926]: info: Hit:2 http://archive.raspberrypi.org/debian buster InRelease Mar 02 06:33:22 volumio3 volumio[926]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease Mar 02 06:33:29 volumio3 volumio[926]: info: Reading package lists... Mar 02 06:33:31 volumio3 volumio[926]: info: CALLMETHOD: user_interface touch_display savePointerConf [object Object] Mar 02 06:33:31 volumio3 volumio[926]: info: CoreCommandRouter::executeOnPlugin: touch_display , savePointerConf Mar 02 06:33:34 volumio3 volumio[926]: info: CALLMETHOD: user_interface touch_display savePointerConf [object Object] Mar 02 06:33:34 volumio3 volumio[926]: info: CoreCommandRouter::executeOnPlugin: touch_display , savePointerConf Mar 02 06:33:41 volumio3 sudo[7825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /ExecStart=\\/usr\\/bin\\/startx \\/etc\\/X11\\/Xsession \\/opt\\/volumiokiosk.sh/c\\ExecStart=\\/usr\\/bin\\/startx \\/etc\\/X11\\/Xsession \\/opt\\/volumiokiosk.sh -- -nocursor /lib/systemd/system/volumio-kiosk.service Mar 02 06:33:41 volumio3 sudo[7825]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:41 volumio3 sudo[7824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /ExecStart=\\/usr\\/bin\\/startx \\/etc\\/X11\\/Xsession \\/opt\\/volumiokiosk.sh/c\\ExecStart=\\/usr\\/bin\\/startx \\/etc\\/X11\\/Xsession \\/opt\\/volumiokiosk.sh -- -nocursor /lib/systemd/system/volumio-kiosk.service Mar 02 06:33:41 volumio3 sudo[7824]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:41 volumio3 sudo[7824]: pam_unix(sudo:session): session closed for user root Mar 02 06:33:41 volumio3 sudo[7825]: pam_unix(sudo:session): session closed for user root Mar 02 06:33:41 volumio3 sudo[7885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 02 06:33:41 volumio3 sudo[7885]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:41 volumio3 sudo[7888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 02 06:33:41 volumio3 sudo[7888]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:41 volumio3 systemd[1]: Reloading. Mar 02 06:33:42 volumio3 volumio[926]: info: Building dependency tree... Mar 02 06:33:42 volumio3 volumio[926]: info: Reading state information... Mar 02 06:33:42 volumio3 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 02 06:33:42 volumio3 volumio[926]: info: All packages are up to date. Mar 02 06:33:43 volumio3 volumio[926]: info: Reading package lists... Mar 02 06:33:43 volumio3 systemd[1]: volumio-kiosk.service: Current command vanished from the unit file, execution of the command list won't be resumed. Mar 02 06:33:43 volumio3 systemd[1]: Reloading. Mar 02 06:33:43 volumio3 sudo[7885]: pam_unix(sudo:session): session closed for user root Mar 02 06:33:43 volumio3 volumio[926]: info: touch_display: systemctl daemon-reload succeeded. Mar 02 06:33:43 volumio3 sudo[7908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service Mar 02 06:33:43 volumio3 sudo[7908]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:43 volumio3 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 02 06:33:44 volumio3 volumio[926]: info: Building dependency tree... Mar 02 06:33:44 volumio3 volumio[926]: info: Reading state information... Mar 02 06:33:44 volumio3 sudo[7888]: pam_unix(sudo:session): session closed for user root Mar 02 06:33:44 volumio3 volumio[926]: info: touch_display: systemctl daemon-reload succeeded. Mar 02 06:33:44 volumio3 sudo[7925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service Mar 02 06:33:44 volumio3 sudo[7925]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 06:33:44 volumio3 startx[6304]: xinit: connection to X server lost Mar 02 06:33:44 volumio3 startx[6304]: [1B blob data] Mar 02 06:33:44 volumio3 volumio[926]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 02 06:33:44 volumio3 systemd[1]: Stopping Volumio Kiosk... Mar 02 06:33:44 volumio3 volumio[926]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 02 06:33:44 volumio3 startx[6304]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Mar 02 06:33:45 volumio3 startx[6304]: xinit: unexpected signal 15 Mar 02 06:33:45 volumio3 systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Mar 02 06:33:45 volumio3 systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Mar 02 06:33:45 volumio3 systemd[1]: Stopped Volumio Kiosk. Mar 02 06:33:45 volumio3 volumio[926]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 02 06:33:45 volumio3 systemd[1]: Started Volumio Kiosk. Mar 02 06:33:45 volumio3 sudo[7908]: pam_unix(sudo:session): session closed for user root Mar 02 06:33:45 volumio3 sudo[7925]: pam_unix(sudo:session): session closed for user root Mar 02 06:33:45 volumio3 volumio[926]: info: touch_display: systemctl restart volumio-kiosk.service succeeded. Mar 02 06:33:45 volumio3 volumio[926]: info: touch_display: Volumio Kiosk restarted. Mar 02 06:33:45 volumio3 volumio[926]: info: touch_display: systemctl restart volumio-kiosk.service succeeded. Mar 02 06:33:45 volumio3 volumio[926]: info: touch_display: Volumio Kiosk restarted. Mar 02 06:33:45 volumio3 volumio[926]: info: The following additional packages will be installed: Mar 02 06:33:45 volumio3 volumio[926]: info: file iso-codes libapt-inst2.0 python-apt-common python3-apt python3-debian Mar 02 06:33:45 volumio3 volumio[926]: info: Suggested packages: Mar 02 06:33:45 volumio3 volumio[926]: info: isoquery python3-apt-dbg python-apt-doc Mar 02 06:33:45 volumio3 volumio[926]: info: touch_display: X display number found: Mar 02 06:33:45 volumio3 volumio[926]: info: touch_display: X display number found: Mar 02 06:33:45 volumio3 startx[7934]: X.Org X Server 1.20.4 Mar 02 06:33:45 volumio3 startx[7934]: X Protocol Version 11, Revision 0 Mar 02 06:33:45 volumio3 startx[7934]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Mar 02 06:33:45 volumio3 startx[7934]: Current Operating System: Linux volumio3 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l Mar 02 06:33:45 volumio3 startx[7934]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=512 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=fb80cb44-b4d3-4b36-be35-613cba0a09fb imgfile=/volumio_current.sqsh bootpart=UUID=51B1-040D datapart=UUID=2899bccc-8620-4c7a-b56a-43fd2f7a836a uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Mar 02 06:33:45 volumio3 startx[7934]: Build Date: 04 April 2023 07:50:56AM Mar 02 06:33:45 volumio3 startx[7934]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Mar 02 06:33:45 volumio3 startx[7934]: Current version of pixman: 0.36.0 Mar 02 06:33:45 volumio3 startx[7934]: Before reporting problems, check http://wiki.x.org Mar 02 06:33:45 volumio3 startx[7934]: to make sure that you have the latest version. Mar 02 06:33:45 volumio3 startx[7934]: Markers: (--) probed, (**) from config file, (==) default setting, Mar 02 06:33:45 volumio3 startx[7934]: (++) from command line, (!!) notice, (II) informational, Mar 02 06:33:45 volumio3 startx[7934]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Mar 02 06:33:45 volumio3 startx[7934]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Mar 2 06:33:45 2025 Mar 02 06:33:45 volumio3 startx[7934]: (==) Using config directory: "/etc/X11/xorg.conf.d" Mar 02 06:33:45 volumio3 startx[7934]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: The following NEW packages will be installed: Mar 02 06:33:46 volumio3 volumio[926]: info: file gdebi-core iso-codes libapt-inst2.0 python-apt-common python3-apt Mar 02 06:33:46 volumio3 volumio[926]: info: python3-debian Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: X display number found: 0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 02 06:33:46 volumio3 volumio[926]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 02 06:33:46 volumio3 volumio[926]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 06:33:46 volumio3 volumio[926]: Error: connect EISCONN /tmp/.X11-unix/X0 Mar 02 06:33:46 volumio3 volumio[926]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 02 06:33:46 volumio3 volumio[926]: errno: -106, Mar 02 06:33:46 volumio3 volumio[926]: code: 'EISCONN', Mar 02 06:33:46 volumio3 volumio[926]: syscall: 'connect', Mar 02 06:33:46 volumio3 volumio[926]: address: '/tmp/.X11-unix/X0' Mar 02 06:33:46 volumio3 volumio[926]: } Mar 02 06:33:46 volumio3 volumio[926]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 06:33:50 volumio3 sudo[8060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-02 06:32 Mar 02 06:33:50 volumio3 sudo[8060]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"