Dec 22 09:56:08 sala systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10620.
Dec 22 09:56:08 sala systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:08 sala systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:08 sala upmpdcli[23080]: Could not open config: /tmp/upmpdcli.conf
Dec 22 09:56:08 sala systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:56:08 sala systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 22 09:56:20 sala go-librespot[1687]: time="2025-12-22T09:56:20+01:00" level=debug msg="connected to ap-guc3.spotify.com:4070"
Dec 22 09:56:20 sala go-librespot[1687]: time="2025-12-22T09:56:20+01:00" level=debug msg="completed keyexchange"
Dec 22 09:56:20 sala go-librespot[1687]: time="2025-12-22T09:56:20+01:00" level=debug msg="completed challenge"
Dec 22 09:56:20 sala go-librespot[1687]: time="2025-12-22T09:56:20+01:00" level=debug msg="renewing login5 access token"
Dec 22 09:56:23 sala systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10621.
Dec 22 09:56:23 sala systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:23 sala systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:23 sala upmpdcli[23113]: Could not open config: /tmp/upmpdcli.conf
Dec 22 09:56:23 sala systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:56:23 sala systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 22 09:56:38 sala systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10622.
Dec 22 09:56:38 sala systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:38 sala systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:38 sala upmpdcli[23131]: Could not open config: /tmp/upmpdcli.conf
Dec 22 09:56:38 sala systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:56:38 sala systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 22 09:56:39 sala go-librespot[1687]: time="2025-12-22T09:56:39+01:00" level=error msg="did not receive last pong ack from accesspoint, 839s passed"
Dec 22 09:56:53 sala systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10623.
Dec 22 09:56:53 sala systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:53 sala systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:56:53 sala upmpdcli[23165]: Could not open config: /tmp/upmpdcli.conf
Dec 22 09:56:53 sala systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:56:53 sala systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 22 09:56:59 sala go-librespot[1687]: time="2025-12-22T09:56:59+01:00" level=debug msg="renewing login5 access token"
Dec 22 09:57:09 sala systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10624.
Dec 22 09:57:09 sala systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:57:09 sala systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:57:09 sala upmpdcli[23186]: Could not open config: /tmp/upmpdcli.conf
Dec 22 09:57:09 sala systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:57:09 sala systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 22 09:57:19 sala go-librespot[1687]: time="2025-12-22T09:57:19+01:00" level=debug msg="connected to ap-gue1.spotify.com:443"
Dec 22 09:57:19 sala go-librespot[1687]: time="2025-12-22T09:57:19+01:00" level=debug msg="completed keyexchange"
Dec 22 09:57:19 sala go-librespot[1687]: time="2025-12-22T09:57:19+01:00" level=debug msg="completed challenge"
Dec 22 09:57:19 sala go-librespot[1687]: time="2025-12-22T09:57:19+01:00" level=error msg="failed reconnecting accesspoint" error="failed authenticating: accesspoint login failed: BadCredentials "
Dec 22 09:57:19 sala go-librespot[1687]: fatal error: sync: Unlock of unlocked RWMutex
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 927949 gp=0x1ce8ea8 m=0 mp=0xce0d20 [running]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.fatal({0x7a3604, 0x20})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/panic.go:1042 +0x4c fp=0x1d57ee0 sp=0x1d57ecc pc=0x597e0
Dec 22 09:57:19 sala go-librespot[1687]: sync.fatal({0x7a3604, 0x20})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/panic.go:1007 +0x24 fp=0x1d57eec sp=0x1d57ee0 pc=0x8ff0c
Dec 22 09:57:19 sala go-librespot[1687]: sync.(*RWMutex).Unlock(0x1e06138)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/sync/rwmutex.go:208 +0x50 fp=0x1d57f04 sp=0x1d57eec pc=0xa0ec0
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x1e060b8)
Dec 22 09:57:19 sala go-librespot[1687]: /src/ap/ap.go:329 +0x4bc fp=0x1d57fe4 sp=0x1d57f04 pc=0x48c784
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/ap/ap.go:390 +0x28 fp=0x1d57fec sp=0x1d57fe4 pc=0x48d010
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d57fec sp=0x1d57fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect in goroutine 925601
Dec 22 09:57:19 sala go-librespot[1687]: /src/ap/ap.go:390 +0x120
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 1 gp=0x1802128 m=nil [select, 2699 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1854d00 sp=0x1854cec pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.selectgo(0x1854e00, 0x18bbdcc, 0x0, 0x0, 0x2, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1854da0 sp=0x1854d00 pc=0x70e78
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x18281e0, 0x1854e90)
Dec 22 09:57:19 sala go-librespot[1687]: /src/zeroconf/zeroconf.go:283 +0x228 fp=0x1854e44 sp=0x1854da0 pc=0x5a8088
Dec 22 09:57:19 sala go-librespot[1687]: main.(*App).withAppPlayer(0x18d4480, {0x8874f0, 0xd0ad00}, 0x18ad140)
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:321 +0x554 fp=0x1854ed0 sp=0x1854e44 pc=0x63db54
Dec 22 09:57:19 sala go-librespot[1687]: main.(*App).withCredentials(...)
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:193
Dec 22 09:57:19 sala go-librespot[1687]: main.(*App).SpotifyToken(0x18d4480, {0x8874f0, 0xd0ad00}, {0x18aaee8, 0x7}, {0x18ea120, 0x120})
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:185 +0xd8 fp=0x1854f00 sp=0x1854ed0 pc=0x63cfa8
Dec 22 09:57:19 sala go-librespot[1687]: main.main()
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:557 +0x588 fp=0x1854fa8 sp=0x1854f00 pc=0x63feb4
Dec 22 09:57:19 sala go-librespot[1687]: runtime.main()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x1854fec sp=0x1854fa8 pc=0x5cb30
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1854fec sp=0x1854fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 2 gp=0x1802c68 m=nil [force gc (idle), 3 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4100, 0xcdf428, 0x11, 0xa, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1844fd4 sp=0x1844fc0 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goparkunlock(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:408
Dec 22 09:57:19 sala go-librespot[1687]: runtime.forcegchelper()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x1844fec sp=0x1844fd4 pc=0x5cefc
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1844fec sp=0x1844fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.init.5 in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:314 +0x1c
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 3 gp=0x1802d88 m=nil [GC sweep wait]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4100, 0xcdfbe0, 0xc, 0x9, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x18457c4 sp=0x18457b0 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goparkunlock(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:408
Dec 22 09:57:19 sala go-librespot[1687]: runtime.bgsweep(0x1874000)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x18457e4 sp=0x18457c4 pc=0x45848
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gcenable.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x18457ec sp=0x18457e4 pc=0x35968
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18457ec sp=0x18457ec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.gcenable in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:203 +0x74
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 4 gp=0x1802ea8 m=nil [GC scavenge wait]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4100, 0xce0208, 0xd, 0xa, 0x2)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1845fb4 sp=0x1845fa0 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goparkunlock(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:408
Dec 22 09:57:19 sala go-librespot[1687]: runtime.(*scavengerState).park(0xce0208)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1845fc8 sp=0x1845fb4 pc=0x42b68
Dec 22 09:57:19 sala go-librespot[1687]: runtime.bgscavenge(0x1874000)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1845fe4 sp=0x1845fc8 pc=0x432a0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gcenable.gowrap2()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x1845fec sp=0x1845fe4 pc=0x35914
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1845fec sp=0x1845fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.gcenable in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:204 +0xbc
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 18 gp=0x1916008 m=nil [finalizer wait, 3 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e3fac, 0xd0ad9c, 0x10, 0xa, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x184078c sp=0x1840778 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.runfinq()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x18407ec sp=0x184078c pc=0x34754
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18407ec sp=0x18407ec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.createfing in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 36 gp=0x188d328 m=nil [IO wait, 1286 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e40f0, 0xb4fc6ec8, 0x2, 0x2, 0x5)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1ab3d28 sp=0x1ab3d14 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.netpollblock(0xb4fc6eb8, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1ab3d40 sp=0x1ab3d28 pc=0x548cc
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.runtime_pollWait(0xb4fc6eb8, 0x72)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1ab3d54 sp=0x1ab3d40 pc=0x8f4a8
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).wait(0x18a72d8, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ab3d68 sp=0x1ab3d54 pc=0x10a318
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).waitRead(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*FD).Accept(0x18a72c0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1ab3db0 sp=0x1ab3d68 pc=0x10eb84
Dec 22 09:57:19 sala go-librespot[1687]: net.(*netFD).accept(0x18a72c0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1ab3e18 sp=0x1ab3db0 pc=0x17e4c4
Dec 22 09:57:19 sala go-librespot[1687]: net.(*TCPListener).accept(0x18ae738)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1ab3e30 sp=0x1ab3e18 pc=0x196900
Dec 22 09:57:19 sala go-librespot[1687]: net.(*TCPListener).Accept(0x18ae738)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x1ab3e4c sp=0x1ab3e30 pc=0x19596c
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*onceCloseListener).Accept(0x18763e0)
Dec 22 09:57:19 sala go-librespot[1687]: :1 +0x34 fp=0x1ab3e64 sp=0x1ab3e4c pc=0x362b54
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*Server).Serve(0x19840a8, {0x886cb8, 0x18ae738})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x1ab3efc sp=0x1ab3e64 pc=0x341210
Dec 22 09:57:19 sala go-librespot[1687]: net/http.Serve(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:2794
Dec 22 09:57:19 sala go-librespot[1687]: main.(*ConcreteApiServer).serve(0x18b2b40)
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/api_server.go:630 +0x974 fp=0x1ab3fe4 sp=0x1ab3efc pc=0x6330b8
Dec 22 09:57:19 sala go-librespot[1687]: main.NewApiServer.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/api_server.go:296 +0x28 fp=0x1ab3fec sp=0x1ab3fe4 pc=0x631de4
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ab3fec sp=0x1ab3fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by main.NewApiServer in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/api_server.go:296 +0x310
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 52 gp=0x1803208 m=nil [chan receive, 1286 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e3f90, 0x18e01b0, 0xe, 0x7, 0x2)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1a8b748 sp=0x1a8b734 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.chanrecv(0x18e0180, 0x1a8b7d0, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1a8b784 sp=0x1a8b748 pc=0x20078
Dec 22 09:57:19 sala go-librespot[1687]: runtime.chanrecv2(0x18e0180, 0x1a8b7d0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1a8b798 sp=0x1a8b784 pc=0x1fbbc
Dec 22 09:57:19 sala go-librespot[1687]: main.(*App).withAppPlayer.func1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:268 +0x68 fp=0x1a8b7ec sp=0x1a8b798 pc=0x63e794
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1a8b7ec sp=0x1a8b7ec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by main.(*App).withAppPlayer in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:265 +0x464
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 16 gp=0x1803328 m=nil [IO wait]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e40f0, 0xb4fc6ce8, 0x2, 0x2, 0x5)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1ab2e84 sp=0x1ab2e70 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.netpollblock(0xb4fc6cd8, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1ab2e9c sp=0x1ab2e84 pc=0x548cc
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.runtime_pollWait(0xb4fc6cd8, 0x72)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1ab2eb0 sp=0x1ab2e9c pc=0x8f4a8
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).wait(0x1caa1f8, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ab2ec4 sp=0x1ab2eb0 pc=0x10a318
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).waitRead(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*FD).RawRead(0x1caa1e0, 0x1cee630)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1ab2ef0 sp=0x1ab2ec4 pc=0x10f788
Dec 22 09:57:19 sala go-librespot[1687]: net.(*rawConn).Read(0x18305d8, 0x1cee630)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x1ab2f10 sp=0x1ab2ef0 pc=0x190d28
Dec 22 09:57:19 sala go-librespot[1687]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x1b822c0, 0x1cee600, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1ab2f40 sp=0x1ab2f10 pc=0x548824
Dec 22 09:57:19 sala go-librespot[1687]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247
Dec 22 09:57:19 sala go-librespot[1687]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x1ca80f8, {0x1aa0000, 0x10000, 0x10000})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x1ab2f9c sp=0x1ab2f40 pc=0x54c80c
Dec 22 09:57:19 sala go-librespot[1687]: github.com/grandcat/zeroconf.(*Server).recv4(0x1878840, 0x1ca80f0)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x1ab2fe0 sp=0x1ab2f9c pc=0x5a309c
Dec 22 09:57:19 sala go-librespot[1687]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x1ab2fec sp=0x1ab2fe0 pc=0x5a2d54
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ab2fec sp=0x1ab2fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 20
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 11 gp=0x1803448 m=nil [GC worker (idle), 1229 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e3fbc, 0x1c06b88, 0x1a, 0xa, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1844790 sp=0x184477c pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gcBgMarkWorker()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x18447ec sp=0x1844790 pc=0x38590
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18447ec sp=0x18447ec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.gcBgMarkStartWorkers in goroutine 9
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1234 +0x20
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 19 gp=0x19166c8 m=nil [GC worker (idle)]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e3fbc, 0x18c6630, 0x1a, 0xa, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1840f90 sp=0x1840f7c pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gcBgMarkWorker()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1840fec sp=0x1840f90 pc=0x38590
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1840fec sp=0x1840fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.gcBgMarkStartWorkers in goroutine 9
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1234 +0x20
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 38 gp=0x188d7a8 m=nil [GC worker (idle), 3 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e3fbc, 0x1c06ba0, 0x1a, 0xa, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1846790 sp=0x184677c pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gcBgMarkWorker()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x18467ec sp=0x1846790 pc=0x38590
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18467ec sp=0x18467ec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.gcBgMarkStartWorkers in goroutine 9
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1234 +0x20
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 12 gp=0x1803688 m=nil [GC worker (idle), 95 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e3fbc, 0x182a4f8, 0x1a, 0xa, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1846f90 sp=0x1846f7c pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gcBgMarkWorker()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1846fec sp=0x1846f90 pc=0x38590
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1846fec sp=0x1846fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by runtime.gcBgMarkStartWorkers in goroutine 9
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/mgc.go:1234 +0x20
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 93 gp=0x188ca28 m=nil [IO wait, 2699 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e40f0, 0xb4fc6888, 0x2, 0x2, 0x5)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1ab687c sp=0x1ab6868 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.netpollblock(0xb4fc6878, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1ab6894 sp=0x1ab687c pc=0x548cc
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.runtime_pollWait(0xb4fc6878, 0x72)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1ab68a8 sp=0x1ab6894 pc=0x8f4a8
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).wait(0x18f8a18, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ab68bc sp=0x1ab68a8 pc=0x10a318
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).waitRead(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*FD).Read(0x18f8a00, {0x1a70000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1ab6904 sp=0x1ab68bc pc=0x10b504
Dec 22 09:57:19 sala go-librespot[1687]: net.(*netFD).Read(0x18f8a00, {0x1a70000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1ab6930 sp=0x1ab6904 pc=0x17c5d0
Dec 22 09:57:19 sala go-librespot[1687]: net.(*conn).Read(0x1cf0fd0, {0x1a70000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1ab695c sp=0x1ab6930 pc=0x18caec
Dec 22 09:57:19 sala go-librespot[1687]: net.(*TCPConn).Read(0x1cf0fd0, {0x1a70000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: :1 +0x44 fp=0x1ab697c sp=0x1ab695c pc=0x19fd40
Dec 22 09:57:19 sala go-librespot[1687]: io.(*multiReader).Read(0x1abc7e0, {0x1a70000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x1ab69a8 sp=0x1ab697c pc=0x105528
Dec 22 09:57:19 sala go-librespot[1687]: bufio.(*Reader).fill(0x18b04e0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x1ab69cc sp=0x1ab69a8 pc=0x2bddb4
Dec 22 09:57:19 sala go-librespot[1687]: bufio.(*Reader).ReadByte(0x18b04e0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x1ab69d8 sp=0x1ab69cc pc=0x2be638
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.readFrameHeader(0x18b04e0, {0x1bfa2b8, 0x8, 0x8})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1ab6a18 sp=0x1ab69d8 pc=0x47788c
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x1bfa288, {0x8874d0, 0xd0ad00})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1ab6ad8 sp=0x1ab6a18 pc=0x47a4f0
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.(*Conn).readLoop(0x1bfa288, {0x8874d0, 0xd0ad00})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1ab6b9c sp=0x1ab6ad8 pc=0x479fd8
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.(*Conn).reader(0x1bfa288, {0x8874d0, 0xd0ad00})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1ab6c28 sp=0x1ab6b9c pc=0x47b1ec
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.(*Conn).Reader(...)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.(*Conn).Read(0x1bfa288, {0x8874d0, 0xd0ad00})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1ab6c50 sp=0x1ab6c28 pc=0x4798bc
Dec 22 09:57:19 sala go-librespot[1687]: main.(*ConcreteApiServer).serve.func17({0x886dec, 0x1984648}, 0x18d3548)
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/api_server.go:600 +0x3c0 fp=0x1ab6ccc sp=0x1ab6c50 pc=0x633988
Dec 22 09:57:19 sala go-librespot[1687]: net/http.HandlerFunc.ServeHTTP(0x18301a0, {0x886dec, 0x1984648}, 0x18d3548)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1ab6cdc sp=0x1ab6ccc pc=0x33d7f4
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*ServeMux).ServeHTTP(0x1982000, {0x886dec, 0x1984648}, 0x18d3548)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1ab6d18 sp=0x1ab6cdc pc=0x33f654
Dec 22 09:57:19 sala go-librespot[1687]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x1984648}, 0x18d3548)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1ab6d40 sp=0x1ab6d18 pc=0x633388
Dec 22 09:57:19 sala go-librespot[1687]: net/http.HandlerFunc.ServeHTTP(0x180e1a0, {0x886dec, 0x1984648}, 0x18d3548)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1ab6d50 sp=0x1ab6d40 pc=0x33d7f4
Dec 22 09:57:19 sala go-librespot[1687]: net/http.serverHandler.ServeHTTP({0x19840a8}, {0x886dec, 0x1984648}, 0x18d3548)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1ab6d6c sp=0x1ab6d50 pc=0x340de4
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*conn).serve(0x1bedc20, {0x887510, 0x1826198})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1ab6fdc sp=0x1ab6d6c pc=0x33c034
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*Server).Serve.gowrap3()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1ab6fec sp=0x1ab6fdc pc=0x341688
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ab6fec sp=0x1ab6fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by net/http.(*Server).Serve in goroutine 36
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:3285 +0x468
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 50 gp=0x1916248 m=nil [IO wait, 2699 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e40f0, 0xb4fc6c48, 0x2, 0x2, 0x5)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x184165c sp=0x1841648 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.netpollblock(0xb4fc6c38, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1841674 sp=0x184165c pc=0x548cc
Dec 22 09:57:19 sala volumio[1259]: info: Connection to go-librespot Websocket closed
Dec 22 09:57:19 sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.runtime_pollWait(0xb4fc6c38, 0x72)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1841688 sp=0x1841674 pc=0x8f4a8
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).wait(0x1caa248, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x184169c sp=0x1841688 pc=0x10a318
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).waitRead(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*FD).RawRead(0x1caa230, 0x1800e40)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x18416c8 sp=0x184169c pc=0x10f788
Dec 22 09:57:19 sala go-librespot[1687]: net.(*rawConn).Read(0x18305f8, 0x1800e40)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x18416e8 sp=0x18416c8 pc=0x190d28
Dec 22 09:57:19 sala go-librespot[1687]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x1b822d0, 0x1800e10, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1841718 sp=0x18416e8 pc=0x548824
Dec 22 09:57:19 sala go-librespot[1687]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247
Dec 22 09:57:19 sala go-librespot[1687]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x1ca8128, {0x1a90000, 0x10000, 0x10000})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x184179c sp=0x1841718 pc=0x550194
Dec 22 09:57:19 sala go-librespot[1687]: github.com/grandcat/zeroconf.(*Server).recv6(0x1878840, 0x1ca8120)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x18417e0 sp=0x184179c pc=0x5a3290
Dec 22 09:57:19 sala go-librespot[1687]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2()
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x18417ec sp=0x18417e0 pc=0x5a2cf8
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18417ec sp=0x18417ec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 20
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 927940 gp=0x18038c8 m=nil [sync.RWMutex.RLock, 16 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4100, 0xce4680, 0x16, 0x5, 0x4)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1857ee8 sp=0x1857ed4 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goparkunlock(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:408
Dec 22 09:57:19 sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 22 09:57:19 sala go-librespot[1687]: runtime.semacquire1(0x1992a00, 0x0, 0x3, 0x0, 0x16)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/sema.go:160 +0x270 fp=0x1857f10 sp=0x1857ee8 pc=0x71ab4
Dec 22 09:57:19 sala go-librespot[1687]: sync.runtime_SemacquireRWMutexR(0x1992a00, 0x0, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/sema.go:82 +0x3c fp=0x1857f28 sp=0x1857f10 pc=0x910d0
Dec 22 09:57:19 sala go-librespot[1687]: sync.(*RWMutex).RLock(0x19929f4)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/sync/rwmutex.go:70 +0x58 fp=0x1857f38 sp=0x1857f28 pc=0xa0bc4
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x19929a8)
Dec 22 09:57:19 sala go-librespot[1687]: /src/dealer/dealer.go:155 +0x2e8 fp=0x1857fe4 sp=0x1857f38 pc=0x531b38
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2()
Dec 22 09:57:19 sala go-librespot[1687]: /src/dealer/dealer.go:129 +0x28 fp=0x1857fec sp=0x1857fe4 pc=0x5337e8
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1857fec sp=0x1857fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 927915
Dec 22 09:57:19 sala go-librespot[1687]: /src/dealer/dealer.go:129 +0x15c
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 927938 gp=0x1a7c008 m=nil [select]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1859eb8 sp=0x1859ea4 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.selectgo(0x1859fd4, 0x1859f7c, 0x0, 0x0, 0x2, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1859f58 sp=0x1859eb8 pc=0x70e78
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x1e060b8)
Dec 22 09:57:19 sala go-librespot[1687]: /src/ap/ap.go:355 +0x8c fp=0x1859fe4 sp=0x1859f58 pc=0x48cb50
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2()
Dec 22 09:57:19 sala go-librespot[1687]: /src/ap/ap.go:264 +0x28 fp=0x1859fec sp=0x1859fe4 pc=0x48c248
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1859fec sp=0x1859fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 927915
Dec 22 09:57:19 sala go-librespot[1687]: /src/ap/ap.go:264 +0x15c
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 53 gp=0x1803568 m=nil [chan receive, 1278 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e3f90, 0x18e0170, 0xe, 0x7, 0x2)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1841f40 sp=0x1841f2c pc=0x5d0c0
Dec 22 09:57:19 sala systemd[1]: go-librespot-daemon.service: Consumed 2min 27.235s CPU time.
Dec 22 09:57:19 sala go-librespot[1687]: runtime.chanrecv(0x18e0140, 0x1acdfe0, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1841f7c sp=0x1841f40 pc=0x20078
Dec 22 09:57:19 sala go-librespot[1687]: runtime.chanrecv2(0x18e0140, 0x1acdfe0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1841f90 sp=0x1841f7c pc=0x1fbbc
Dec 22 09:57:19 sala go-librespot[1687]: main.(*App).withAppPlayer.func2()
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:284 +0x6c fp=0x1841fec sp=0x1841f90 pc=0x63e330
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1841fec sp=0x1841fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by main.(*App).withAppPlayer in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:281 +0x504
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 54 gp=0x18037a8 m=nil [IO wait, 55 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e40f0, 0xb4fc6d88, 0x2, 0x2, 0x5)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x18425e8 sp=0x18425d4 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.netpollblock(0xb4fc6d78, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1842600 sp=0x18425e8 pc=0x548cc
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.runtime_pollWait(0xb4fc6d78, 0x72)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1842614 sp=0x1842600 pc=0x8f4a8
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).wait(0x1caa1a8, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1842628 sp=0x1842614 pc=0x10a318
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).waitRead(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*FD).Accept(0x1caa190)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1842670 sp=0x1842628 pc=0x10eb84
Dec 22 09:57:19 sala go-librespot[1687]: net.(*netFD).accept(0x1caa190)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x18426d8 sp=0x1842670 pc=0x17e4c4
Dec 22 09:57:19 sala go-librespot[1687]: net.(*TCPListener).accept(0x1c9c1b0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x18426f0 sp=0x18426d8 pc=0x196900
Dec 22 09:57:19 sala go-librespot[1687]: net.(*TCPListener).Accept(0x1c9c1b0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x184270c sp=0x18426f0 pc=0x19596c
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*onceCloseListener).Accept(0x1bcc0c0)
Dec 22 09:57:19 sala go-librespot[1687]: :1 +0x34 fp=0x1842724 sp=0x184270c pc=0x362b54
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*Server).Serve(0x1984468, {0x886cb8, 0x1c9c1b0})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x18427bc sp=0x1842724 pc=0x341210
Dec 22 09:57:19 sala go-librespot[1687]: net/http.Serve(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/server.go:2794
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2()
Dec 22 09:57:19 sala go-librespot[1687]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x18427ec sp=0x18427bc pc=0x5a8184
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18427ec sp=0x18427ec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1
Dec 22 09:57:19 sala go-librespot[1687]: /src/zeroconf/zeroconf.go:280 +0x160
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 62 gp=0x19165a8 m=nil [select, 1278 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1a8eea8 sp=0x1a8ee94 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.selectgo(0x1a8efa4, 0x1a8ef6c, 0x0, 0x0, 0x5, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1a8ef48 sp=0x1a8eea8 pc=0x70e78
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x1bfa288)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x1a8efe4 sp=0x1a8ef48 pc=0x474738
Dec 22 09:57:19 sala go-librespot[1687]: nhooyr.io/websocket.newConn.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x1a8efec sp=0x1a8efe4 pc=0x47432c
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1a8efec sp=0x1a8efec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by nhooyr.io/websocket.newConn in goroutine 93
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 927914 gp=0x1ce9b08 m=nil [select, 1278 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d4fe74 sp=0x1d4fe60 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.selectgo(0x1d4ff74, 0x1d4ff3c, 0x0, 0x0, 0x3, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1d4ff14 sp=0x1d4fe74 pc=0x70e78
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x1b0bae0)
Dec 22 09:57:19 sala go-librespot[1687]: /src/player/player.go:201 +0x1fc fp=0x1d4ffe4 sp=0x1d4ff14 pc=0x513660
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/player/player.go:183 +0x28 fp=0x1d4ffec sp=0x1d4ffe4 pc=0x513240
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d4ffec sp=0x1d4ffec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 53
Dec 22 09:57:19 sala go-librespot[1687]: /src/player/player.go:183 +0x218
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 927915 gp=0x18fb688 m=nil [select, 155 minutes]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d5b844 sp=0x1d5b830 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.selectgo(0x1d5be10, 0x1d5ba24, 0x0, 0x0, 0x8, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1d5b8e4 sp=0x1d5b844 pc=0x70e78
Dec 22 09:57:19 sala go-librespot[1687]: main.(*AppPlayer).Run(0x19a4320, {0x8874f0, 0xd0ad00}, 0x1d2cc40)
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/player.go:590 +0x370 fp=0x1d5bfd8 sp=0x1d5b8e4 pc=0x6458bc
Dec 22 09:57:19 sala go-librespot[1687]: main.(*App).withAppPlayer.func2.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:309 +0x40 fp=0x1d5bfec sp=0x1d5bfd8 pc=0x63e700
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d5bfec sp=0x1d5bfec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by main.(*App).withAppPlayer.func2 in goroutine 53
Dec 22 09:57:19 sala go-librespot[1687]: /src/cmd/daemon/main.go:309 +0x2c8
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 927986 gp=0x2b7e488 m=nil [IO wait]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e40f0, 0xb4fc6ba8, 0x2, 0x2, 0x5)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1855ad4 sp=0x1855ac0 pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.netpollblock(0xb4fc6b98, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1855aec sp=0x1855ad4 pc=0x548cc
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.runtime_pollWait(0xb4fc6b98, 0x72)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1855b00 sp=0x1855aec pc=0x8f4a8
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).wait(0x1b0b3c8, 0x72, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1855b14 sp=0x1855b00 pc=0x10a318
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*pollDesc).waitRead(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89
Dec 22 09:57:19 sala go-librespot[1687]: internal/poll.(*FD).Read(0x1b0b3b0, {0x1e08000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1855b5c sp=0x1855b14 pc=0x10b504
Dec 22 09:57:19 sala go-librespot[1687]: net.(*netFD).Read(0x1b0b3b0, {0x1e08000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1855b88 sp=0x1855b5c pc=0x17c5d0
Dec 22 09:57:19 sala go-librespot[1687]: net.(*conn).Read(0x1898168, {0x1e08000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1855bb4 sp=0x1855b88 pc=0x18caec
Dec 22 09:57:19 sala go-librespot[1687]: net.(*TCPConn).Read(0x1898168, {0x1e08000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: :1 +0x44 fp=0x1855bd4 sp=0x1855bb4 pc=0x19fd40
Dec 22 09:57:19 sala go-librespot[1687]: crypto/tls.(*atLeastReader).Read(0x180e290, {0x1e08000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1855c00 sp=0x1855bd4 pc=0x27c680
Dec 22 09:57:19 sala go-librespot[1687]: bytes.(*Buffer).ReadFrom(0x1b9d14c, {0x883674, 0x180e290})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1855c3c sp=0x1855c00 pc=0x139bd0
Dec 22 09:57:19 sala go-librespot[1687]: crypto/tls.(*Conn).readFromUntil(0x1b9cfc8, {0x882848, 0x1898168}, 0x5)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1855c64 sp=0x1855c3c pc=0x27c8dc
Dec 22 09:57:19 sala go-librespot[1687]: crypto/tls.(*Conn).readRecordOrCCS(0x1b9cfc8, 0x0)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1855dc8 sp=0x1855c64 pc=0x279fdc
Dec 22 09:57:19 sala go-librespot[1687]: crypto/tls.(*Conn).readRecord(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/crypto/tls/conn.go:588
Dec 22 09:57:19 sala go-librespot[1687]: crypto/tls.(*Conn).Read(0x1b9cfc8, {0x199c000, 0x1000, 0x1000})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1855df8 sp=0x1855dc8 pc=0x27fe4c
Dec 22 09:57:19 sala go-librespot[1687]: bufio.(*Reader).Read(0x2535320, {0x18d4124, 0x9, 0x9})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1855e1c sp=0x1855df8 pc=0x2be440
Dec 22 09:57:19 sala go-librespot[1687]: io.ReadAtLeast({0x882a3c, 0x2535320}, {0x18d4124, 0x9, 0x9}, 0x9)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1855e48 sp=0x1855e1c pc=0x1042c0
Dec 22 09:57:19 sala go-librespot[1687]: io.ReadFull(...)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/io/io.go:354
Dec 22 09:57:19 sala go-librespot[1687]: net/http.http2readFrameHeader({0x18d4124, 0x9, 0x9}, {0x882a3c, 0x2535320})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1855e70 sp=0x1855e48 pc=0x2f733c
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*http2Framer).ReadFrame(0x18d4100)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1855eec sp=0x1855e70 pc=0x2f7ad4
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*http2clientConnReadLoop).run(0x1855fdc)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1855fa4 sp=0x1855eec pc=0x31c2f0
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*http2ClientConn).readLoop(0x1957d08)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1855fe4 sp=0x1855fa4 pc=0x31b7e4
Dec 22 09:57:19 sala go-librespot[1687]: net/http.(*http2Transport).newClientConn.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1855fec sp=0x1855fe4 pc=0x314830
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1855fec sp=0x1855fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by net/http.(*http2Transport).newClientConn in goroutine 927953
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0
Dec 22 09:57:19 sala go-librespot[1687]: goroutine 927939 gp=0x1e0db08 m=nil [select]:
Dec 22 09:57:19 sala go-librespot[1687]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1ae9de0 sp=0x1ae9dcc pc=0x5d0c0
Dec 22 09:57:19 sala go-librespot[1687]: runtime.selectgo(0x1ae9ed4, 0x1ae9ea8, 0x0, 0x0, 0x2, 0x1)
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1ae9e80 sp=0x1ae9de0 pc=0x70e78
Dec 22 09:57:19 sala go-librespot[1687]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x1ae9f24, {0x886440, 0x1d34000}, 0x0, {0x0, 0x0})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:112 +0x260 fp=0x1ae9efc sp=0x1ae9e80 pc=0x480870
Dec 22 09:57:19 sala go-librespot[1687]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x1ae9f74, {0x886440, 0x1d34000}, 0x0, {0x0, 0x0})
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:61 +0x6c fp=0x1ae9f2c sp=0x1ae9efc pc=0x4801e0
Dec 22 09:57:19 sala go-librespot[1687]: github.com/cenkalti/backoff/v4.RetryNotify(...)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:49
Dec 22 09:57:19 sala go-librespot[1687]: github.com/cenkalti/backoff/v4.Retry(...)
Dec 22 09:57:19 sala go-librespot[1687]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:38
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x19929a8)
Dec 22 09:57:19 sala go-librespot[1687]: /src/dealer/dealer.go:237 +0x688 fp=0x1ae9fe4 sp=0x1ae9f2c pc=0x532394
Dec 22 09:57:19 sala go-librespot[1687]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1()
Dec 22 09:57:19 sala go-librespot[1687]: /src/dealer/dealer.go:125 +0x28 fp=0x1ae9fec sp=0x1ae9fe4 pc=0x53383c
Dec 22 09:57:19 sala go-librespot[1687]: runtime.goexit({})
Dec 22 09:57:19 sala go-librespot[1687]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ae9fec sp=0x1ae9fec pc=0x93d6c
Dec 22 09:57:19 sala go-librespot[1687]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 927915
Dec 22 09:57:19 sala go-librespot[1687]: /src/dealer/dealer.go:125 +0x98
Dec 22 09:57:19 sala go-librespot[1686]: Aborted
Dec 22 09:57:22 sala volumio[1259]: info: Initializing connection to go-librespot Websocket
Dec 22 09:57:22 sala volumio[1259]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 22 09:57:22 sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1.
Dec 22 09:57:22 sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:22 sala systemd[1]: go-librespot-daemon.service: Consumed 2min 27.235s CPU time.
Dec 22 09:57:22 sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:22 sala go-librespot[23220]: go-librespot daemon starting...
Dec 22 09:57:22 sala go-librespot[23221]: time="2025-12-22T09:57:22+01:00" level=info msg="running go-librespot 0.4.0"
Dec 22 09:57:22 sala go-librespot[23221]: time="2025-12-22T09:57:22+01:00" level=debug msg="app state loaded"
Dec 22 09:57:22 sala go-librespot[23221]: time="2025-12-22T09:57:22+01:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 22 09:57:22 sala go-librespot[23221]: time="2025-12-22T09:57:22+01: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Dec 22 09:57:22 sala go-librespot[23221]: time="2025-12-22T09:57:22+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Dec 22 09:57:22 sala go-librespot[23221]: time="2025-12-22T09:57:22+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Dec 22 09:57:22 sala go-librespot[23221]: time="2025-12-22T09:57:22+01:00" level=info msg="zeroconf server listening on port 38323"
Dec 22 09:57:23 sala go-librespot[23221]: time="2025-12-22T09:57:23+01:00" level=debug msg="obtained new client token: AADjGKKNIQcz/xsajHKTzkwNNlhj6sJwaYTJZ8raiM5AcSTltsxBYvEHk1uXkH2SHYuWIIQ1D20ofvacAlkRqSXrJtJ3JBYFpgQy4UqzvzhBRwMRJGaQNo05nnJSYyCKhkL0d+8WRyfVBHkd/D42pHpvB6hawPSkDIFbsbu60FSG8wprqDXBxSh7XCyibOaJPEqPxU/+8YlZehCH7UQYKI7apzO1l8f3DTzA6DhUJcJN+wpqubYx"
Dec 22 09:57:23 sala go-librespot[23221]: time="2025-12-22T09:57:23+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
Dec 22 09:57:23 sala go-librespot[23221]: time="2025-12-22T09:57:23+01:00" level=debug msg="completed keyexchange"
Dec 22 09:57:23 sala go-librespot[23221]: time="2025-12-22T09:57:23+01:00" level=debug msg="completed challenge"
Dec 22 09:57:23 sala go-librespot[23221]: time="2025-12-22T09:57:23+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 22 09:57:23 sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:57:23 sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 22 09:57:24 sala systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10625.
Dec 22 09:57:24 sala systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:57:24 sala systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 22 09:57:24 sala upmpdcli[23228]: Could not open config: /tmp/upmpdcli.conf
Dec 22 09:57:24 sala systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:57:24 sala systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 22 09:57:25 sala volumio[1259]: info: Initializing connection to go-librespot Websocket
Dec 22 09:57:25 sala volumio[1259]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 22 09:57:26 sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2.
Dec 22 09:57:26 sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:26 sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:26 sala go-librespot[23230]: go-librespot daemon starting...
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=info msg="running go-librespot 0.4.0"
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=debug msg="app state loaded"
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=info msg="zeroconf server listening on port 38491"
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=debug msg="obtained new client token: AADqEdPVxqhAx9qIGu4qZ4AGn2cYo1Vqg1xdXSxKhVZ5xYkt2g7wM7PVr59XF7NQGmq1YVledDvpmxZ3xz70FvTKX6ZyB3athn9610wyIBV68pLmQ5ZMcSaTjXrArS449TYM5Knie97SY10TIbeeiwHZHN7E46PmTbt2i3f/WRw1LZ/QUsMfsmrxlabLVB4Kud0NLLYowe2SEK/4ic/jvcIO6IF2bUjXzNZFZRhnMEXC+LApSqrbIzY="
Dec 22 09:57:26 sala go-librespot[23231]: time="2025-12-22T09:57:26+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
Dec 22 09:57:27 sala go-librespot[23231]: time="2025-12-22T09:57:27+01:00" level=debug msg="completed keyexchange"
Dec 22 09:57:27 sala go-librespot[23231]: time="2025-12-22T09:57:27+01:00" level=debug msg="completed challenge"
Dec 22 09:57:27 sala go-librespot[23231]: time="2025-12-22T09:57:27+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 22 09:57:27 sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:57:27 sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 22 09:57:28 sala volumio[1259]: info: Initializing connection to go-librespot Websocket
Dec 22 09:57:28 sala volumio[1259]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 22 09:57:30 sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3.
Dec 22 09:57:30 sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:30 sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:30 sala go-librespot[23238]: go-librespot daemon starting...
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=info msg="running go-librespot 0.4.0"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=debug msg="app state loaded"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01: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]"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01: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]"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01: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]"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=info msg="zeroconf server listening on port 46235"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=debug msg="obtained new client token: AAAtMSkZ/XvIEfL4ZHTsCLNtOzugnHF0cNSHxNaE8uTXZebkm9iJMvRaSjRnqasXETzIpwS4YZ1psc56qC8ekfMGT+BNA4oPFl8VgweZzduR22v4AE6afB/L2Bs4ciCxzRpileVwOfIn7GYyu9AllHY6rWzz/3243CL2U23/pgYzCVZV3CYMPrGG5Nlbg0sQfsjrGj3xuj9EX+sXOXnIZhZ648uq1JLGuLNLgdNCoPbLtxV8df7WAWc="
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=debug msg="completed keyexchange"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=debug msg="completed challenge"
Dec 22 09:57:30 sala go-librespot[23239]: time="2025-12-22T09:57:30+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 22 09:57:30 sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:57:30 sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 22 09:57:31 sala volumio[1259]: info: Initializing connection to go-librespot Websocket
Dec 22 09:57:31 sala volumio[1259]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 22 09:57:33 sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4.
Dec 22 09:57:33 sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:33 sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:33 sala go-librespot[23260]: go-librespot daemon starting...
Dec 22 09:57:33 sala go-librespot[23261]: time="2025-12-22T09:57:33+01:00" level=info msg="running go-librespot 0.4.0"
Dec 22 09:57:33 sala go-librespot[23261]: time="2025-12-22T09:57:33+01:00" level=debug msg="app state loaded"
Dec 22 09:57:33 sala go-librespot[23261]: time="2025-12-22T09:57:33+01:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=info msg="zeroconf server listening on port 44297"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=debug msg="obtained new client token: AADo0M0/Vqc9B8X8yC1bMynu0qx293Bzy7ySq35Mw4m6fXyuaVbRYmpiUbCH+RHtOCqbz6FOPUpMOxd751n7lU09QuSF9Yv0J5MGQTW+tgFYq/af2g6jmHWz0KEQ8D5RJ5n794PmEih3FyD5JrB6tl6IjwqfFzjZzLiBvAbMsCFpCECvmFkeFNjaXKY2OOlRf4HqsIG/RREBawNcufZlMnhWSR333KCaggyFlsUbNDMNgyd9TxJTHBw="
Dec 22 09:57:34 sala volumio[1259]: info: Initializing connection to go-librespot Websocket
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=debug msg="new websocket client"
Dec 22 09:57:34 sala volumio[1259]: info: Connection to go-librespot Websocket established
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=debug msg="completed keyexchange"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=debug msg="completed challenge"
Dec 22 09:57:34 sala go-librespot[23261]: time="2025-12-22T09:57:34+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 22 09:57:34 sala volumio[1259]: info: Connection to go-librespot Websocket closed
Dec 22 09:57:34 sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 22 09:57:34 sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 22 09:57:37 sala volumio[1259]: info: Getting Spotify volume
Dec 22 09:57:37 sala volumio[1259]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 22 09:57:37 sala volumio[1259]: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 22 09:57:37 sala volumio[1259]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 22 09:57:37 sala volumio[1259]: errno: -111,
Dec 22 09:57:37 sala volumio[1259]: code: 'ECONNREFUSED',
Dec 22 09:57:37 sala volumio[1259]: syscall: 'connect',
Dec 22 09:57:37 sala volumio[1259]: address: '127.0.0.1',
Dec 22 09:57:37 sala volumio[1259]: port: 9879,
Dec 22 09:57:37 sala volumio[1259]: response: undefined
Dec 22 09:57:37 sala volumio[1259]: }
Dec 22 09:57:37 sala volumio[1259]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 22 09:57:37 sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5.
Dec 22 09:57:37 sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:37 sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 22 09:57:37 sala go-librespot[23281]: go-librespot daemon starting...
Dec 22 09:57:37 sala go-librespot[23282]: time="2025-12-22T09:57:37+01:00" level=info msg="running go-librespot 0.4.0"
Dec 22 09:57:37 sala go-librespot[23282]: time="2025-12-22T09:57:37+01:00" level=debug msg="app state loaded"
Dec 22 09:57:37 sala go-librespot[23282]: time="2025-12-22T09:57:37+01:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 22 09:57:37 sala sudo[23290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-22 09:56'
Dec 22 09:57:37 sala sudo[23290]: 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"