-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-10-06 14:18:02 CEST. -- Oct 06 14:17:03 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:17:03 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:17:03 dudel volumio[800]: info: Listing playlists Oct 06 14:17:03 dudel volumio[800]: info: Listing playlists Oct 06 14:17:13 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:17:13 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:17:23 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:17:23 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:17:23 dudel volumio[800]: info: Listing playlists Oct 06 14:17:23 dudel volumio[800]: info: Listing playlists Oct 06 14:17:33 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:17:33 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:17:43 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:17:43 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:17:43 dudel volumio[800]: info: Listing playlists Oct 06 14:17:43 dudel volumio[800]: info: Listing playlists Oct 06 14:17:53 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:17:53 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:17:58 dudel volumio[800]: info: Enabling plugin spop Oct 06 14:17:58 dudel volumio[800]: info: Loading plugin "spop"... Oct 06 14:17:58 dudel volumio[800]: info: PLUGIN START: spop Oct 06 14:17:58 dudel volumio[800]: info: Creating Spotify config file Oct 06 14:17:58 dudel volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 14:17:58 dudel volumio[800]: info: Done. Oct 06 14:17:58 dudel volumio[800]: info: Spotify config file written Oct 06 14:17:58 dudel sudo[3019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 06 14:17:58 dudel sudo[3019]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 14:17:58 dudel systemd[1]: Started go-librespot Daemon. Oct 06 14:17:58 dudel go-librespot[3021]: Librespot-go daemon starting... Oct 06 14:17:58 dudel sudo[3019]: pam_unix(sudo:session): session closed for user root Oct 06 14:17:58 dudel go-librespot[3021]: time="2024-10-06T14:17:58+02:00" level=info msg="generated new device id: d0501be6f5b8a7046916ef1fb83aa34600bb0533" Oct 06 14:17:58 dudel go-librespot[3021]: time="2024-10-06T14:17:58+02:00" level=debug msg="stored credentials found for 314ei2lkci2tfaqrgodqeax3ne6m" Oct 06 14:17:58 dudel go-librespot[3021]: time="2024-10-06T14:17:58+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 06 14:17:58 dudel go-librespot[3021]: time="2024-10-06T14:17:58+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 06 14:17:58 dudel go-librespot[3021]: time="2024-10-06T14:17:58+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 06 14:17:58 dudel go-librespot[3021]: time="2024-10-06T14:17:58+02:00" level=debug msg="zeroconf server listening on port 45575" Oct 06 14:17:59 dudel go-librespot[3021]: time="2024-10-06T14:17:59+02:00" level=debug msg="obtained new client token: AADrYf+1LXj7y6LGb0L65Dy4VDy+n8nzbmwVoGzZTcW7smBQCzUrc2X1CCGp2w6lCS26GZ2zH6otFmJx8WBObzJCBVgJ/EalDSxdFO66G771Rc3ksjF3+HZfFxzNDHrUm3IKOxJgM5GGG9zl3xvStPQ/RgsQrTTR6qrBk4C0tX0V7nSb3+kQGKwVlWRVqVA9r+K+V5XdWWaSOG+qUEhiKAbiJKFTAXNWDdUmccDueoxsb/dnkb1doUnE5Wz0WQ==" Oct 06 14:17:59 dudel volumio[800]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 06 14:17:59 dudel volumio[800]: SPOTIFY: BQC3akG4Up2QPz5ABH3PWpG0eD6-eFXahYC4vGSFVQx13n_Sc42tUK1cXJvZzmEyxk-Ffrh47xw7MQE256hrox4pkAHIM83p8VqXFuuQWHd-D4LSTFxIceMSWd6ToOPSokpmxuj-hN9GmRQoP2OmdLqX66LGF2KR1hXFIiJmuul403Na9QtDxZRLcaTC69ZUk-6ZB4635UtxCDZnFcIj8xA5jvQqW2q858DrdLAHoan7AFxrydUdRoYQENDMqiKvmxiwPnnpFDWoJitC Oct 06 14:17:59 dudel volumio[800]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 06 14:17:59 dudel volumio[800]: info: New Spotify access token = BQC3akG4Up2QPz5ABH3PWpG0eD6-eFXahYC4vGSFVQx13n_Sc42tUK1cXJvZzmEyxk-Ffrh47xw7MQE256hrox4pkAHIM83p8VqXFuuQWHd-D4LSTFxIceMSWd6ToOPSokpmxuj-hN9GmRQoP2OmdLqX66LGF2KR1hXFIiJmuul403Na9QtDxZRLcaTC69ZUk-6ZB4635UtxCDZnFcIj8xA5jvQqW2q858DrdLAHoan7AFxrydUdRoYQENDMqiKvmxiwPnnpFDWoJitC Oct 06 14:17:59 dudel volumio[800]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 06 14:17:59 dudel go-librespot[3021]: time="2024-10-06T14:17:59+02:00" level=info msg="connected to ap-gew4.spotify.com:4070" Oct 06 14:17:59 dudel go-librespot[3021]: time="2024-10-06T14:17:59+02:00" level=debug msg="completed keyexchange" Oct 06 14:17:59 dudel volumio[800]: SPOTIFY: User informations: {"display_name":"Ronja","external_urls":{"spotify":"https://open.spotify.com/user/314ei2lkci2tfaqrgodqeax3ne6m"},"href":"https://api.spotify.com/v1/users/314ei2lkci2tfaqrgodqeax3ne6m","id":"314ei2lkci2tfaqrgodqeax3ne6m","images":[],"type":"user","uri":"spotify:user:314ei2lkci2tfaqrgodqeax3ne6m","followers":{"href":null,"total":0},"country":"DE","product":"premium","explicit_content":{"filter_enabled":true,"filter_locked":true},"email":"ronja.login@posteo.net"} Oct 06 14:17:59 dudel volumio[800]: info: Spotify Successfully logged in Oct 06 14:17:59 dudel volumio[800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 14:17:59 dudel volumio[800]: info: [1728217079368] CoreMusicLibrary::Adding element Spotify Oct 06 14:17:59 dudel volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 14:17:59 dudel volumio[800]: Cannot find translation for source Spotify Oct 06 14:17:59 dudel go-librespot[3021]: time="2024-10-06T14:17:59+02:00" level=debug msg="completed challenge" Oct 06 14:17:59 dudel go-librespot[3021]: time="2024-10-06T14:17:59+02:00" level=debug msg="authenticated as 314ei2lkci2tfaqrgodqeax3ne6m" Oct 06 14:17:59 dudel volumio[800]: info: Enabling plugin touch_display Oct 06 14:17:59 dudel volumio[800]: info: Loading plugin "touch_display"... Oct 06 14:17:59 dudel volumio[800]: info: Applying required configuration parameters for plugin touch_display Oct 06 14:17:59 dudel go-librespot[3021]: time="2024-10-06T14:17:59+02:00" level=debug msg="authenticated as 314ei2lkci2tfaqrgodqeax3ne6m" Oct 06 14:18:00 dudel volumio[800]: info: PLUGIN START: touch_display Oct 06 14:18:00 dudel volumio[800]: info: Loading i18n strings for locale de Oct 06 14:18:00 dudel volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 14:18:00 dudel volumio[800]: info: touch_display: Raspberry Pi Foundation touch screen detected. Oct 06 14:18:00 dudel volumio[800]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected. Oct 06 14:18:00 dudel sudo[3030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 06 14:18:00 dudel sudo[3030]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 14:18:00 dudel systemd[1]: Reloading. Oct 06 14:18:00 dudel sudo[3036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness Oct 06 14:18:00 dudel sudo[3036]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 14:18:00 dudel sudo[3036]: pam_unix(sudo:session): session closed for user root Oct 06 14:18:00 dudel volumio[800]: info: touch_display: File permissions for backlight brightness control set. Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="dealer connection opened" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="initializing zeroconf session, username: 314ei2lkci2tfaqrgodqeax3ne6m" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="received connection id: M2Q2ZTM3YzktMjFjOC00OTc4LWFjMDAtMTBmZmM5NmU0YmExK2RlYWxlcit0Y3A6Ly8wYWNhNThmZi5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMEU5QzE2MDJFNTUzRUQyRTdDREMxNDNCNTI4QTc2NDc3NjJFMDdDQUIwN0FENjcxNUFENTczRjE3MUM2MjZGNg==" Oct 06 14:18:00 dudel sudo[3034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 06 14:18:00 dudel sudo[3034]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 14:18:00 dudel sudo[3034]: pam_unix(sudo:session): session closed for user root Oct 06 14:18:00 dudel volumio[800]: info: touch_display: Touchscreen transformation matrix removed. Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="put connect state because NEW_DEVICE" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 493" Oct 06 14:18:00 dudel go-librespot[3021]: time="2024-10-06T14:18:00+02:00" level=debug msg="autoplay enabled: false" Oct 06 14:18:00 dudel 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. Oct 06 14:18:00 dudel ntpd[854]: 80.50.102.206 local addr 172.23.135.73 -> Oct 06 14:18:00 dudel sudo[3030]: pam_unix(sudo:session): session closed for user root Oct 06 14:18:00 dudel volumio[800]: info: touch_display: systemctl daemon-reload succeeded. Oct 06 14:18:00 dudel sudo[3055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Oct 06 14:18:00 dudel sudo[3055]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 14:18:00 dudel systemd[1]: Started Volumio Kiosk. Oct 06 14:18:00 dudel sudo[3055]: pam_unix(sudo:session): session closed for user root Oct 06 14:18:00 dudel volumio[800]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Oct 06 14:18:00 dudel volumio[800]: info: touch_display: Volumio Kiosk started Oct 06 14:18:00 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:18:00 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:18:01 dudel volumio[800]: info: Done. Oct 06 14:18:01 dudel volumio[800]: info: CoreCommandRouter::volumioGetState Oct 06 14:18:01 dudel volumio[800]: info: CorePlayQueue::getTrack 0 Oct 06 14:18:01 dudel volumio[800]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X Oct 06 14:18:01 dudel volumio[800]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X Oct 06 14:18:01 dudel startx[3057]: X.Org X Server 1.20.4 Oct 06 14:18:01 dudel startx[3057]: X Protocol Version 11, Revision 0 Oct 06 14:18:01 dudel startx[3057]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Oct 06 14:18:01 dudel startx[3057]: Current Operating System: Linux dudel 6.1.69-v7+ #1710 SMP Thu Dec 21 13:14:13 GMT 2023 armv7l Oct 06 14:18:01 dudel startx[3057]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 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=9b6a8fd4-d1e0-41c3-90e3-655c7141a81c imgfile=/volumio_current.sqsh bootpart=UUID=7883-9333 datapart=UUID=f0f21e6a-0d4c-4d61-b970-25cec5bd08b3 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 Oct 06 14:18:01 dudel startx[3057]: Build Date: 04 April 2023 07:50:56AM Oct 06 14:18:01 dudel startx[3057]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Oct 06 14:18:01 dudel startx[3057]: Current version of pixman: 0.36.0 Oct 06 14:18:01 dudel startx[3057]: Before reporting problems, check http://wiki.x.org Oct 06 14:18:01 dudel startx[3057]: to make sure that you have the latest version. Oct 06 14:18:01 dudel startx[3057]: Markers: (--) probed, (**) from config file, (==) default setting, Oct 06 14:18:01 dudel startx[3057]: (++) from command line, (!!) notice, (II) informational, Oct 06 14:18:01 dudel startx[3057]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Oct 06 14:18:01 dudel startx[3057]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Oct 6 14:18:01 2024 Oct 06 14:18:01 dudel startx[3057]: (==) Using config directory: "/etc/X11/xorg.conf.d" Oct 06 14:18:01 dudel startx[3057]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Oct 06 14:18:01 dudel volumio[800]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 06 14:18:01 dudel sudo[3091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Oct 06 14:18:01 dudel sudo[3091]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 14:18:01 dudel systemd[1]: Stopping Volumio Kiosk... Oct 06 14:18:01 dudel volumio[800]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 06 14:18:01 dudel sudo[3089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 06 14:18:01 dudel sudo[3089]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 14:18:01 dudel sudo[3089]: pam_unix(sudo:session): session closed for user root Oct 06 14:18:01 dudel volumio[800]: info: touch_display: Touchscreen transformation matrix removed. Oct 06 14:18:01 dudel volumio[800]: info: go-librespot daemon successfully initialized Oct 06 14:18:02 dudel startx[3057]: [1B blob data] Oct 06 14:18:02 dudel volumio[800]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 14:18:02 dudel startx[3057]: waiting for X server to begin accepting connections (II) Server terminated successfully (0). Closing log file. Oct 06 14:18:02 dudel volumio[800]: Error: read ECONNRESET Oct 06 14:18:02 dudel volumio[800]: at Pipe.onStreamRead (internal/stream_base_commons.js:209:20) { Oct 06 14:18:02 dudel volumio[800]: errno: -104, Oct 06 14:18:02 dudel volumio[800]: code: 'ECONNRESET', Oct 06 14:18:02 dudel volumio[800]: syscall: 'read' Oct 06 14:18:02 dudel volumio[800]: } Oct 06 14:18:02 dudel volumio[800]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 14:18:02 dudel sudo[3117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 14:17 Oct 06 14:18:02 dudel sudo[3117]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"