-- Logs begin at Tue 2025-05-20 05:12:32 CEST, end at Tue 2025-05-20 07:18:40 CEST. -- May 20 07:17:00 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:00 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:02 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:02 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14437. May 20 07:17:02 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:02 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:02 biuro-it go-librespot[7602]: go-librespot daemon starting... May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=debug msg="app state loaded" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=debug msg="stored credentials not found" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02: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]" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02: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]" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=info msg="zeroconf server listening on port 40605" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=debug msg="obtained new client token: AADyNARfKmBemsJAnqHUI2qmM7vzLna385tGK+MwGaCewmtS+6wrSIQTPYE91MyICkwnaZR7BtsJm0YX4pYIX+4b3WX9V7noBr5nzRmXejWFJh0wgp0hgElBSKHNceBHPVetmcf37fX5nAmTX6B52UFC6U53QYGywkr8DD6RwLwe95M+6K0IIClFSssA5ujsIfcqUU1qqIrhNvzG+/WGvx0X/y0jYZOzXM8XlUf7uNoljeaLltSOw4ZboZ1m" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=debug msg="completed keyexchange" May 20 07:17:02 biuro-it go-librespot[7602]: time="2025-05-20T07:17:02+02:00" level=debug msg="completed challenge" May 20 07:17:03 biuro-it go-librespot[7602]: time="2025-05-20T07:17:03+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:03 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:03 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:03 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:03 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:04 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:06 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:06 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:06 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:06 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14438. May 20 07:17:06 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:06 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:06 biuro-it go-librespot[7610]: go-librespot daemon starting... May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=debug msg="app state loaded" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=debug msg="stored credentials not found" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+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]" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+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]" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+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]" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=info msg="zeroconf server listening on port 44665" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=debug msg="obtained new client token: AAAnoAmGM3r1o+7iOKpFs5VrW4GTa2msh6QxnD9r6CAjFpKuFTwysx9ZyNMDKOoIoaQ6G0GHbeGsNuxa1Y/YnGQ338cAX8aMlIbd4p27xtJbuxfAraw/qHQ0iF2AP0dVo/H5dspQE8dPFeDMgiCPVAKxUGwmrZe3bBcEDRX3esgpzRSvVO0RKxwDY2hXoKr41WcIRTQ/gCiAD9pXbVU6bhrnpv7pZVhGMfgPZJr2urh6v2FKVmKq3rA4J4E9" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=debug msg="completed keyexchange" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=debug msg="completed challenge" May 20 07:17:06 biuro-it go-librespot[7610]: time="2025-05-20T07:17:06+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:06 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:06 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:09 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:09 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:09 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:09 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:09 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14439. May 20 07:17:09 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:09 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:09 biuro-it go-librespot[7632]: go-librespot daemon starting... May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=debug msg="app state loaded" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=debug msg="stored credentials not found" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+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]" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+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]" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+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]" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=info msg="zeroconf server listening on port 33895" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=debug msg="obtained new client token: AAC7cxtjXXIwBNxAna1YdpqWaV1AO2qqfeLMoBjfCa7pc7nuwXXK72brYy5X5mBfZIwB84drRkEHINBlUqu2bX7idt3+nInGSd76xaxNgQ0XArp+Rr/nR9cg4Wac8C7340DsSgs39boAzNnIOF3Y3DC17iZ2Ka3niAjFncLDuhWSrozTIWbf7uratoSfbGaB50ZLumgHF+v3PUtnWT3W6Nm5IvewYWrXzG0zKyO2W6mjXQ1eq4euogzk1SzJ" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=debug msg="completed keyexchange" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=debug msg="completed challenge" May 20 07:17:10 biuro-it go-librespot[7632]: time="2025-05-20T07:17:10+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:10 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:10 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:12 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:12 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:13 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:13 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14440. May 20 07:17:13 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:13 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:13 biuro-it go-librespot[7641]: go-librespot daemon starting... May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+02:00" level=debug msg="app state loaded" May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+02:00" level=debug msg="stored credentials not found" May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+02: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]" May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+02: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]" May 20 07:17:13 biuro-it go-librespot[7641]: time="2025-05-20T07:17:13+02:00" level=info msg="zeroconf server listening on port 44927" May 20 07:17:14 biuro-it go-librespot[7641]: time="2025-05-20T07:17:14+02:00" level=debug msg="obtained new client token: AAC6roCKxHwCe5GGorjiS0zcF1gEibNBG8qZe6K+Q9NewfekAg1JtoWK1+ZhP4ZEw60ZK3ViT1jIhF7gRLUcIy1fLOCnMCYo1hzi23dzq9svrgpEZoqKH/qeCZrUQrUfYCzw2w52KRXHuA2GygocLEo/ddd1my6KMWnCXDH9tIMJGjNukW0s1CsPfoXIshJ4GmODS/kHXQ/DvFMQtaTcCQT7/QYT5DvJg1+tflMCH4qgiArYIUzTVnmF9Q==" May 20 07:17:14 biuro-it go-librespot[7641]: time="2025-05-20T07:17:14+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:14 biuro-it go-librespot[7641]: time="2025-05-20T07:17:14+02:00" level=debug msg="completed keyexchange" May 20 07:17:14 biuro-it go-librespot[7641]: time="2025-05-20T07:17:14+02:00" level=debug msg="completed challenge" May 20 07:17:14 biuro-it go-librespot[7641]: time="2025-05-20T07:17:14+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:14 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:14 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:15 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:15 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:15 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:15 biuro-it nmbd[754]: [2025/05/20 07:17:15.910838, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 20 07:17:15 biuro-it nmbd[754]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.10.199 for name WORKGROUP<1d>. May 20 07:17:15 biuro-it nmbd[754]: This response was from IP 192.168.10.184, reporting an IP address of 192.168.10.184. May 20 07:17:17 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:17 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14441. May 20 07:17:17 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:17 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:17 biuro-it go-librespot[7652]: go-librespot daemon starting... May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+02:00" level=debug msg="app state loaded" May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+02:00" level=debug msg="stored credentials not found" May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" May 20 07:17:17 biuro-it go-librespot[7652]: time="2025-05-20T07:17:17+02:00" level=info msg="zeroconf server listening on port 33275" May 20 07:17:18 biuro-it go-librespot[7652]: time="2025-05-20T07:17:18+02:00" level=debug msg="obtained new client token: AAA4/RLnSJ7jkr2/yU21Q6F7yRMlWKbxE0HfFJ/ACB9Ci3/FSrFNW+Zm7N2g5dVwiLqjivTbB9E8+YBzVRzPbVZIVfSbN6JVSSl8Br3MHjlI5Vnx5PJMgVg7hPZ7tEAuR4kAB7N9c2y/0WYMgssIiwPMjD2+zuXuJXGu0Qj5YXyNjte87cL75wh/BPhAk7Dm/KUQzYBYiivA/M00MevKpYcZyMkv+54Aen/9w2xIGHGZTYqaQLT4fh9VPg==" May 20 07:17:18 biuro-it go-librespot[7652]: time="2025-05-20T07:17:18+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:18 biuro-it go-librespot[7652]: time="2025-05-20T07:17:18+02:00" level=debug msg="completed keyexchange" May 20 07:17:18 biuro-it go-librespot[7652]: time="2025-05-20T07:17:18+02:00" level=debug msg="completed challenge" May 20 07:17:18 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:18 biuro-it go-librespot[7652]: time="2025-05-20T07:17:18+02:00" level=debug msg="new websocket client" May 20 07:17:18 biuro-it volumio[1117]: info: Connection to go-librespot Websocket established May 20 07:17:18 biuro-it go-librespot[7652]: time="2025-05-20T07:17:18+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:18 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:18 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:18 biuro-it volumio[1117]: info: Connection to go-librespot Websocket closed May 20 07:17:20 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:21 biuro-it volumio[1117]: info: Getting Spotify volume May 20 07:17:21 biuro-it volumio[1117]: (node:1117) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:21 biuro-it volumio[1117]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) May 20 07:17:21 biuro-it volumio[1117]: (node:1117) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 2600) May 20 07:17:21 biuro-it volumio[1117]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 20 07:17:21 biuro-it volumio[1117]: info: CoreCommandRouter::volumioGetState May 20 07:17:21 biuro-it volumio[1117]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 May 20 07:17:21 biuro-it volumio[1117]: SPOTIFY: SPOTIFY VOLUME 30 May 20 07:17:21 biuro-it volumio[1117]: SPOTIFY: VOLUMIO VOLUME 29 May 20 07:17:21 biuro-it volumio[1117]: SPOTIFY: DELTA VOLUME ENOUGH: false May 20 07:17:21 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:21 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:21 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:21 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14442. May 20 07:17:21 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:21 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:21 biuro-it go-librespot[7677]: go-librespot daemon starting... May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=debug msg="app state loaded" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=debug msg="stored credentials not found" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02: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]" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02: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]" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=info msg="zeroconf server listening on port 44203" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=debug msg="obtained new client token: AACNgKabUnfmzV3k8U+vsYOU5TjCm7Stcrt/uj2PLTPIGLsIiFcwDJ29PorwJpIXApaFZUlaHnttJSffqQ3M4Mt2uN6rn7fKcW9gOroquWarznkqZl/OSuwtsUd06jlAQ/y7Z8YqR5EfE9zeNezjVWUcxb8yYTLtIEViLIOykXEIK84KJlnBOVV72E2AtPJ5sEdX3DMIVFb3AqIkGMhdDehP1+8cj1HhPa127sodIM692l5ZbNJRCNHnaCsD" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=debug msg="completed keyexchange" May 20 07:17:21 biuro-it go-librespot[7677]: time="2025-05-20T07:17:21+02:00" level=debug msg="completed challenge" May 20 07:17:22 biuro-it go-librespot[7677]: time="2025-05-20T07:17:22+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:22 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:22 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:24 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:24 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:25 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:25 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14443. May 20 07:17:25 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:25 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:25 biuro-it go-librespot[7685]: go-librespot daemon starting... May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="app state loaded" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="stored credentials not found" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=info msg="zeroconf server listening on port 37583" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="obtained new client token: AAASjjGJdWFHtWOn1NSmjPAslKFGb3qw6JsqsZoOsIkQMfA/aAszPPMjIF3AwDWAKC/vYdtjH5wjI1FJH59Si68judN2il3k5weDe2yU3hmygHLdyHKAhAdcM8X3V3hcDLerNklXD5YFQtPAehe2bNZi00NitZ6aVmyF693AQHOgrRVRHEptvTiqv1XC7GykhDx9LzduxfLNEWEeuo7wwzsqYrAp627rSRfs4Ibe5gjVFs4si0drz6zGomAj" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="completed keyexchange" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=debug msg="completed challenge" May 20 07:17:25 biuro-it go-librespot[7685]: time="2025-05-20T07:17:25+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:25 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:25 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:26 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:27 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:27 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:28 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:28 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14444. May 20 07:17:28 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:29 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:29 biuro-it go-librespot[7693]: go-librespot daemon starting... May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="app state loaded" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="stored credentials not found" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=info msg="zeroconf server listening on port 35341" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="obtained new client token: AABS7Z4zUVxfQzCodeSqqJPvygbG2qL+YCeXmTNQsKVrdsmmHRm8xTh06SQTLy0/YkP0WO3nS2yGzhsifXT981tb9qCKbCR514axMjrtvk2AkfKwO1Rttzj4Bjn73ecstMPx6hdmUavUFjcNmZgPMf7nMA6Pk+3gDGwHpoNUb0Be8gHbgyW2VIlJ76TBgpqB5Sq1PtMUMsfPFsTgGJ47lbAUCxmfbxAD98MeflRH1FQdBDNYovuEMOJ5QlRV" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="completed keyexchange" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=debug msg="completed challenge" May 20 07:17:29 biuro-it go-librespot[7693]: time="2025-05-20T07:17:29+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:29 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:29 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:30 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:30 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:31 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:32 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:32 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14445. May 20 07:17:32 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:32 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:32 biuro-it go-librespot[7715]: go-librespot daemon starting... May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=debug msg="app state loaded" May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=debug msg="stored credentials not found" May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:17:32 biuro-it go-librespot[7715]: time="2025-05-20T07:17:32+02:00" level=info msg="zeroconf server listening on port 44401" May 20 07:17:33 biuro-it go-librespot[7715]: time="2025-05-20T07:17:33+02:00" level=debug msg="obtained new client token: AACCikXo/QswE6VvHgU4IUVvgtYJAQyaX3LytSaekIC11A5GRrB9GPcEzHHHLDQssx9KVQYj4mpyWHbDLh6upeDHLQ0nc2CbuXiOxihvGXPKVxzSXZrb1nLELeeAr95pD5lFopoEj6HhQvemc6+F3OcRGrYs31nsN89JIR0naONSrqC0TjmMbfhBC8QBv5GpCqh39+D12XkPmqe0R4CbvxnqRqAjwoLUdj7lncSQ6xfX84BlBFeUwLM9gQ==" May 20 07:17:33 biuro-it go-librespot[7715]: time="2025-05-20T07:17:33+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:33 biuro-it go-librespot[7715]: time="2025-05-20T07:17:33+02:00" level=debug msg="completed keyexchange" May 20 07:17:33 biuro-it go-librespot[7715]: time="2025-05-20T07:17:33+02:00" level=debug msg="completed challenge" May 20 07:17:33 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:33 biuro-it go-librespot[7715]: time="2025-05-20T07:17:33+02:00" level=debug msg="new websocket client" May 20 07:17:33 biuro-it volumio[1117]: info: Connection to go-librespot Websocket established May 20 07:17:33 biuro-it go-librespot[7715]: time="2025-05-20T07:17:33+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:33 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:33 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:33 biuro-it volumio[1117]: info: Connection to go-librespot Websocket closed May 20 07:17:36 biuro-it volumio[1117]: info: Getting Spotify volume May 20 07:17:36 biuro-it volumio[1117]: (node:1117) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:36 biuro-it volumio[1117]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) May 20 07:17:36 biuro-it volumio[1117]: (node:1117) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 2601) May 20 07:17:36 biuro-it volumio[1117]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 20 07:17:36 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:36 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:36 biuro-it volumio[1117]: info: CoreCommandRouter::volumioGetState May 20 07:17:36 biuro-it volumio[1117]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 May 20 07:17:36 biuro-it volumio[1117]: SPOTIFY: SPOTIFY VOLUME 30 May 20 07:17:36 biuro-it volumio[1117]: SPOTIFY: VOLUMIO VOLUME 29 May 20 07:17:36 biuro-it volumio[1117]: SPOTIFY: DELTA VOLUME ENOUGH: false May 20 07:17:36 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:36 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14446. May 20 07:17:36 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:36 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:36 biuro-it go-librespot[7724]: go-librespot daemon starting... May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="app state loaded" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="stored credentials not found" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=info msg="zeroconf server listening on port 33539" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="obtained new client token: AABB33iDvMGoPL+W53/TuyOGsrvKif6ZWYNEPwGPwH2c0gN7ylTqJkGoI+qjBQRpGfU9w9f7Gjn2YmcqXUelF0KWWrsJVm6OtgGNNlLoVp1w84js75U6cusWdoH0ONswseBEE5dxR+jeBB+mD9/XRdix3B5IJs77RYeh19UGDyWqxlgbp5S/xApj46kwCi0WFmUbp8QCuZa+OmsgypeI8qYwbDZK8B6vR92IwOsGX541oI1mq4kIoHWGswhV" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="completed keyexchange" May 20 07:17:36 biuro-it go-librespot[7724]: time="2025-05-20T07:17:36+02:00" level=debug msg="completed challenge" May 20 07:17:37 biuro-it go-librespot[7724]: time="2025-05-20T07:17:37+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:37 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:37 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:37 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:39 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:39 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:40 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:40 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14447. May 20 07:17:40 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:40 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:40 biuro-it go-librespot[7751]: go-librespot daemon starting... May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="app state loaded" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="stored credentials not found" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=info msg="zeroconf server listening on port 41071" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="obtained new client token: AADHESbq+nxJBTekwWANmbbFZcWpXtxI/GJjqRdkcy2BaTcC6IM9LaqSG6hYV25lyy6eCBFlGTInPK4pvGL/Spb9bD9cKneyU9fpvrqbsV9ZtLkylJTEzWx2Z5PQNaP6eT57pDZ3KZxJjeDAp847fB/gd9OkEJoIabCdh/1HMfKET18H6TnFfxvbivOC+jyDIUyjhbB13qzOC1HdBIOHTdQmTVgPipjW1M7vKNapY+ZfNhAgXUpEmMZOxFfn" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="completed keyexchange" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=debug msg="completed challenge" May 20 07:17:40 biuro-it go-librespot[7751]: time="2025-05-20T07:17:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:40 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:40 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:42 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:42 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:42 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:43 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:43 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14448. May 20 07:17:43 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:43 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:44 biuro-it go-librespot[7759]: go-librespot daemon starting... May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=debug msg="app state loaded" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=debug msg="stored credentials not found" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+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]" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+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]" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+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]" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=info msg="zeroconf server listening on port 35557" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=debug msg="obtained new client token: AAAeSTeQVDGabUiy+j7j0g97Sm1I+S5qi9N5V0SEk4lXJn10gaCGKrcTS+DfP23giqR8xN6wSTOg0NgndFQFh+vBxCttKdGIDzNFbV6Tlu7OaOFGWAYX9vP5W8jBIHoAB8h4jjEFgRVokSY9uz6BC1jTyjwaJrks9B69vjfq4CCLtEGDUICSW50csa8/1TF+RP3usghh6MYmlkrkZUO8d1X4fgjwVE6EfBC/g6UJiNDruii3UIasEajhbWti" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=debug msg="completed keyexchange" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=debug msg="completed challenge" May 20 07:17:44 biuro-it go-librespot[7759]: time="2025-05-20T07:17:44+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:44 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:44 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:45 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:45 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:47 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:47 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14449. May 20 07:17:47 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:47 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:47 biuro-it go-librespot[7767]: go-librespot daemon starting... May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+02:00" level=debug msg="app state loaded" May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+02:00" level=debug msg="stored credentials not found" May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+02: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]" May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+02: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]" May 20 07:17:47 biuro-it go-librespot[7767]: time="2025-05-20T07:17:47+02:00" level=info msg="zeroconf server listening on port 39147" May 20 07:17:48 biuro-it go-librespot[7767]: time="2025-05-20T07:17:48+02:00" level=debug msg="obtained new client token: AAD5mXJDCivpVDrTQr9zJqDIgDhwZXH1/dDS0nkT94HhN2jTLDN/L2y6LMieQqkglzAu8ekn2iTC792c8DUrfpoB9IAYdMFrWUKFLr846xSBuxiy+loxzKIAtroL1+R+0CQ3XwzyGxZ/VxXDK+Lo6YZA5jPWOiE2xTiffZK22zovD1FSnGD7Yzwg0yIndM19I5tq0+6dXd+mH9qZmUku3auQrFBc/I+4hZ5ynhthSyVZ61DjGlQX51ju/w==" May 20 07:17:48 biuro-it go-librespot[7767]: time="2025-05-20T07:17:48+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:48 biuro-it go-librespot[7767]: time="2025-05-20T07:17:48+02:00" level=debug msg="completed keyexchange" May 20 07:17:48 biuro-it go-librespot[7767]: time="2025-05-20T07:17:48+02:00" level=debug msg="completed challenge" May 20 07:17:48 biuro-it go-librespot[7767]: time="2025-05-20T07:17:48+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:48 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:48 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:48 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:48 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:48 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:51 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:51 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:51 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:51 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14450. May 20 07:17:51 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:51 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:51 biuro-it go-librespot[7791]: go-librespot daemon starting... May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=debug msg="app state loaded" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=debug msg="stored credentials not found" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02: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]" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02: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]" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=info msg="zeroconf server listening on port 45647" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=debug msg="obtained new client token: AABEyww9VzMSPUZ8YuKPCX+5LyOwJnPAgemEDXxqt2VgZzGGgNLEhmboNTHann8ddsRaOwN3PCEpEt9MYXgy45q8T/+KqTngxuEKC0BUBpFoLiNTAfqQtK4GU290TIU5kpnglK+hPK/9GVM/5bmRrrdAO45IMygzqNs+HiXL50ppp1nruEVRkCaeDK2MfMkplmcDnU8Lb3fbdy3ml3u+La0Z9Th7NPrtM+9RJ34VJqHxBW9WgO/HkhHQ3ANQ" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=debug msg="completed keyexchange" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=debug msg="completed challenge" May 20 07:17:51 biuro-it go-librespot[7791]: time="2025-05-20T07:17:51+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:51 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:51 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:53 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:54 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:54 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:55 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:55 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14451. May 20 07:17:55 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:55 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:55 biuro-it go-librespot[7800]: go-librespot daemon starting... May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="app state loaded" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="stored credentials not found" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=info msg="zeroconf server listening on port 41213" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="obtained new client token: AAArD2Gk6/Act8Pn8DodF304Y1Efiv5bHpdCnXvQKeSBP9MI7uS43kJq1b15SQt7VqL9+z9cui7HojOz0qEwdVF9pnpU8uLMoBhHxF7F36rkI+ahM4V/ikgLHumNMpaHBllKZF2xpYiElWeNHtswN9NUl/SKf2espCY7myjOC9vju7WnziVtHPpVh11lbotx1BY2g2V7OlWFIUnJSC1pA/IZ6O6kq+9Ot8MJocjWOX9LJqkvuD/+jnozjua1" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="completed keyexchange" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=debug msg="completed challenge" May 20 07:17:55 biuro-it go-librespot[7800]: time="2025-05-20T07:17:55+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:55 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:55 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:17:57 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:17:57 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:17:58 biuro-it volumiologrotate[580]: ls: cannot access '/var/log/samba/log.wb-BIURO': No such file or directory May 20 07:17:58 biuro-it volumiologrotate[580]: ls: cannot access 'IT': No such file or directory May 20 07:17:58 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:17:58 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14452. May 20 07:17:58 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:17:58 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:17:59 biuro-it go-librespot[7852]: go-librespot daemon starting... May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=debug msg="app state loaded" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=debug msg="stored credentials not found" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+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]" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+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]" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+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]" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=info msg="zeroconf server listening on port 42873" May 20 07:17:59 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=debug msg="obtained new client token: AADR6gD5BCOBULyhAXSKREP/1Igf16B5Q2cGDB4l5x6kspH79MrW/bXxhe5Q6crPhF/I25Qwy8L1qVA907d7A5VRvgElt+v4EOGyNUXtBa/GoJ0By5TxaEmIjpyAkjwKCszkxMCyMOXE4qcGNI5B5AmMNE5E3OkkhndjTW6M72k6LdJ1S6AdtdieBuai3AsliK0/z7/6EURoGHImdticGYCdgXeA+iQxUZ1PLyco0IthJ8B0aZSAmgZEYMxc" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=debug msg="completed keyexchange" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=debug msg="completed challenge" May 20 07:17:59 biuro-it go-librespot[7852]: time="2025-05-20T07:17:59+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:17:59 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:17:59 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:00 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:00 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:02 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:02 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14453. May 20 07:18:02 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:02 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:02 biuro-it go-librespot[7877]: go-librespot daemon starting... May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=debug msg="app state loaded" May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=debug msg="stored credentials not found" May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:18:02 biuro-it go-librespot[7877]: time="2025-05-20T07:18:02+02:00" level=info msg="zeroconf server listening on port 44591" May 20 07:18:03 biuro-it go-librespot[7877]: time="2025-05-20T07:18:03+02:00" level=debug msg="obtained new client token: AADYQ0z/PzrEhELMeBMteH7CRYXw4Jq5vT9NzSlGFmTqM5WQGUphdf5JJkaUCD+BjoUFkrUZFHPdvjW54sto6iIQyUPntaPA1pdhAOqfyIJvECqqmfab3qTy/21i9ilJZMIqZE3pKHUfLBGPu16jubI5vCwrpibcmH74+d1TOGBtJNvWaNYWugqrnEljq+ZXp6+nJB3eXicnoaUARgxUBMUq2f/X9Ye+j+6MfpzUNJ7qFMn+MIlSJTPh6w==" May 20 07:18:03 biuro-it go-librespot[7877]: time="2025-05-20T07:18:03+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:03 biuro-it go-librespot[7877]: time="2025-05-20T07:18:03+02:00" level=debug msg="completed keyexchange" May 20 07:18:03 biuro-it go-librespot[7877]: time="2025-05-20T07:18:03+02:00" level=debug msg="completed challenge" May 20 07:18:03 biuro-it go-librespot[7877]: time="2025-05-20T07:18:03+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:03 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:03 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:03 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:03 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:04 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:18:06 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:06 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:06 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:06 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14454. May 20 07:18:06 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:06 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:06 biuro-it go-librespot[7885]: go-librespot daemon starting... May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=debug msg="app state loaded" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=debug msg="stored credentials not found" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02: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]" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02: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]" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=info msg="zeroconf server listening on port 37161" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=debug msg="obtained new client token: AAAOEYlau8r3D6zD8SQzQRQzqmUjGI07RGRFMlh6zCRB90DYwYssB2Z9AhAvdWbTtKxxGK1fS0xgg1QoTrP1gk/sajRcBZyk18+vX7X7b2xdKDdtgC7iJ9kardJQsCqBmeO8K7ThnNhpT/hUUPzWMBVSCJ+IyiNPyn8iEQRmjZTO2bQ1w2iKd0sS5VBPncsYr79fuf1woh/VZpkYrI97pka6A63uoNIVD7uLbIYUIrcZZyScDnKhM5GDJI6u" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=debug msg="completed keyexchange" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=debug msg="completed challenge" May 20 07:18:06 biuro-it go-librespot[7885]: time="2025-05-20T07:18:06+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:07 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:07 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:09 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:09 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:10 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:10 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14455. May 20 07:18:10 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:10 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:10 biuro-it go-librespot[7908]: go-librespot daemon starting... May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="app state loaded" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="stored credentials not found" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:10 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=info msg="zeroconf server listening on port 38167" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="obtained new client token: AAAEDZvymwJA+YKLUc3nZzvPYmfCb6WDKuwr1c++/f/Sc/jh3OuuglpH9TRfJjDt4ePV1BJRglKjBOppO8cQabuRBves+31jeE0QuhAPRJq/UlgF7yT/4mkek738GL9LQi7O70zuGIb2DdUXGMe+t40dmOe2Pu7eQ3GFY03q5pBhx+wXBgJAqf8cSOKRajDl9yo6HUqP5w7WQaRpZYSOMu+65WjSMJuiJDGQOizBJP/THNB0G4OVrjGaNf6M" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="completed keyexchange" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=debug msg="completed challenge" May 20 07:18:10 biuro-it go-librespot[7908]: time="2025-05-20T07:18:10+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:10 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:10 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:12 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:12 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:13 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:13 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14456. May 20 07:18:13 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:13 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:13 biuro-it go-librespot[7916]: go-librespot daemon starting... May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=debug msg="app state loaded" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=debug msg="stored credentials not found" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+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]" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+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]" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+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]" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=info msg="zeroconf server listening on port 44011" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=debug msg="obtained new client token: AADYwO9wnt+DVMxg9mCYBa1bQTlelggTM1dnIMWTtT5LDceBIE8F4sMc4flBF10012aCRwnwRLA+uvgA93LGOHARB/YGrqk0z8soDbaXjNWDj2RkD0N3aAHnOb+mHlVJNYhNfDkQYui5qLEhTBqiYlMSTDPL8Gm5zsPtsjvbwJkUKFeHOLJBb3fxqhCH0rYzZvWjL1CWu2qLNYvCfmIZItFMwfWxIgpE+LeKLvVNoa2duc7fWyzT3CDdselH" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=debug msg="completed keyexchange" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=debug msg="completed challenge" May 20 07:18:14 biuro-it go-librespot[7916]: time="2025-05-20T07:18:14+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:14 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:14 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:15 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:15 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:15 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:15 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:15 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:18:17 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:17 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:17 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:17 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14457. May 20 07:18:17 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:17 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:17 biuro-it go-librespot[7926]: go-librespot daemon starting... May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+02:00" level=debug msg="app state loaded" May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+02:00" level=debug msg="stored credentials not found" May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+02: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]" May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+02: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]" May 20 07:18:17 biuro-it go-librespot[7926]: time="2025-05-20T07:18:17+02:00" level=info msg="zeroconf server listening on port 34647" May 20 07:18:18 biuro-it go-librespot[7926]: time="2025-05-20T07:18:18+02:00" level=debug msg="obtained new client token: AABz95xn/HftJd3J/yYQLwHajYSkOXF3GjOJoU8GOFSNl2mRDJpXn28twajX5sdz3Sp8b6vm2u0WwUuR+xBDT95g3LdUGXNpDNNnrieq9uYMlFJLaRrms4oFBFn14WHCXeWPJqJS5iM80mNGVGL1PL3v/73RjIfV9MampzRCgZ2j1oZ3Ndb1SjaDoxrli7yCj4GdPjaU2CU3gk4ZVIfNs91LiD3qytcjT4D7IVzNkYZgVEehnqy/9vZUgw==" May 20 07:18:18 biuro-it go-librespot[7926]: time="2025-05-20T07:18:18+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:18 biuro-it go-librespot[7926]: time="2025-05-20T07:18:18+02:00" level=debug msg="completed keyexchange" May 20 07:18:18 biuro-it go-librespot[7926]: time="2025-05-20T07:18:18+02:00" level=debug msg="completed challenge" May 20 07:18:18 biuro-it go-librespot[7926]: time="2025-05-20T07:18:18+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:18 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:18 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:18 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:18 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:18 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:18 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:19 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:19 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:20 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:20 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:20 biuro-it volumio[1117]: info: Preloading song: upnp/http://192.168.10.199:8200/ctl/ContentDir@1$7$0$0 May 20 07:18:20 biuro-it volumio[1117]: info: Preloading song: upnp/http://192.168.10.199:8200/ctl/ContentDir@1$7$0$1 May 20 07:18:20 biuro-it volumio[1117]: info: Preloading song: upnp/http://192.168.10.199:8200/ctl/ContentDir@1$7$0$2 May 20 07:18:20 biuro-it volumio[1117]: info: Exploding uri upnp/http://192.168.10.199:8200/ctl/ContentDir@1$7$0$0 in service upnp_browser May 20 07:18:20 biuro-it volumio[1117]: info: No valid Plugin REST Endpoint May 20 07:18:20 biuro-it volumio[1117]: info: No valid Plugin REST Endpoint May 20 07:18:20 biuro-it volumio[1117]: info: No valid Plugin REST Endpoint May 20 07:18:20 biuro-it volumio[1117]: info: No valid Plugin REST Endpoint May 20 07:18:20 biuro-it volumio[1117]: info: No valid Plugin REST Endpoint May 20 07:18:20 biuro-it volumio[1117]: info: No valid Plugin REST Endpoint May 20 07:18:20 biuro-it volumio[1117]: info: Exploding uri upnp/http://192.168.10.199:8200/ctl/ContentDir@1$7$0$1 in service upnp_browser May 20 07:18:20 biuro-it volumio[1117]: info: Exploding uri upnp/http://192.168.10.199:8200/ctl/ContentDir@1$7$0$2 in service upnp_browser May 20 07:18:21 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:21 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:21 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:18:21 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:21 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14458. May 20 07:18:21 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:21 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:21 biuro-it go-librespot[7951]: go-librespot daemon starting... May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="app state loaded" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="stored credentials not found" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=info msg="zeroconf server listening on port 44095" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="obtained new client token: AAAsCRq57DwdUb6vjzyZ9yaYomZf/aQusjCtqIoKfpVJ455ChNqkklW4wtNJf3S2R8YRxez9pEaRJxiwurXA4qhityScCQMKh7pApyHASHzwFpPIstGCM/tO+XgOfgyUFOpXD0FgmOYlDTZ5dz+0ua94qDzHbZaCJnvopbGS7tMgtDKZ6eA6rI8lCNd6Mlyjm5zTUR2MhpydXxVrE0ehXmuM6mC79Ob/3gkv6Nk3MuvHXgMonInkJa1pzanA" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="completed keyexchange" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=debug msg="completed challenge" May 20 07:18:21 biuro-it go-librespot[7951]: time="2025-05-20T07:18:21+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:21 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:21 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:24 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:24 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:25 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:25 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14459. May 20 07:18:25 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:25 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:25 biuro-it go-librespot[7960]: go-librespot daemon starting... May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=debug msg="app state loaded" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=debug msg="stored credentials not found" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02: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]" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02: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]" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=info msg="zeroconf server listening on port 34371" May 20 07:18:25 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=debug msg="obtained new client token: AABxtaudDisyLJXSo5KvXxlnJcUwSbgucnZVgjhVo/OCeIPtza57FCIzdillImTFpSPfeMiUXU2Rl8tTLuO6R4He8t+9N4H5OCruvUpRqP2bmjbRd+DS9srfJG/6i0qjPjBSAC+a9mQdEjiE6Cidcw+FvPtdto3hTvdkZm7t3fDZnl2HyIuO39BuiZXmwm/i/hcnak+Z7+XTF1tfHqWH5PkhDWlwCgvooCVk5R210FpSfo/8kRmN2rbQ/PgF" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:25 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=debug msg="completed keyexchange" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=debug msg="completed challenge" May 20 07:18:25 biuro-it go-librespot[7960]: time="2025-05-20T07:18:25+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:25 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:25 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:26 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:18:27 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:27 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:28 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:28 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:28 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:28 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:28 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:28 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14460. May 20 07:18:28 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:29 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:29 biuro-it go-librespot[7970]: go-librespot daemon starting... May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="app state loaded" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="stored credentials not found" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=info msg="zeroconf server listening on port 42683" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="obtained new client token: AAA6kaezT5S5BxByDHNumjKaxoOlgPhEKOxSs0L9aT5fCd+TU2h3X37FTCI7hlPDwcZcaNmrcF4qWd05sjObNGr4dEMhI9WVdpizPoclfECF0fSWoBgKXWvKtp6Udu9VYMxtEGPJpb/oA792koM41OLh08TfNNoQLqRETkuGF/GidEx07MtqjKQNgf/9gJZ5rGRm1Cb+lMdqgQFqtUjOYBBAHQeVL6rygt4X6BkOgRVzbP4weheY+7zaIL4E" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="completed keyexchange" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=debug msg="completed challenge" May 20 07:18:29 biuro-it go-librespot[7970]: time="2025-05-20T07:18:29+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:29 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:29 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:30 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:30 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:32 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:18:32 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:32 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14461. May 20 07:18:32 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:32 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:32 biuro-it go-librespot[7992]: go-librespot daemon starting... May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=debug msg="app state loaded" May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=debug msg="stored credentials not found" May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:18:32 biuro-it go-librespot[7992]: time="2025-05-20T07:18:32+02:00" level=info msg="zeroconf server listening on port 40503" May 20 07:18:33 biuro-it go-librespot[7992]: time="2025-05-20T07:18:33+02:00" level=debug msg="obtained new client token: AAA2lLpUwSNJyNcuDe6gzWFutCtVioh1zdR+7nHVt2ZEXYGvHVGxCC5dGIQbjg2p4Fi6d94wgKURLVHVHWmJvoujwd0xbG9PahuNPVCLTxv3daegvkg6Rwbmxp082v7u44srT0Krrsz3SR2AO+iNB4G3SEhd9OdVjtjBwytgKmnyt3qR/oYkNv3ZuDqas7NcII0CAQ4d0WBy02TUVLaJhskMaRR5TBz4DGH6ENaB4Udr1fdrCRwW201L9A==" May 20 07:18:33 biuro-it go-librespot[7992]: time="2025-05-20T07:18:33+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:33 biuro-it go-librespot[7992]: time="2025-05-20T07:18:33+02:00" level=debug msg="completed keyexchange" May 20 07:18:33 biuro-it go-librespot[7992]: time="2025-05-20T07:18:33+02:00" level=debug msg="completed challenge" May 20 07:18:33 biuro-it go-librespot[7992]: time="2025-05-20T07:18:33+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:33 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:33 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:33 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:33 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:36 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:36 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:36 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:36 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:36 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:36 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14462. May 20 07:18:36 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:36 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:36 biuro-it go-librespot[8004]: go-librespot daemon starting... May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="app state loaded" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="stored credentials not found" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=info msg="zeroconf server listening on port 38497" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="obtained new client token: AADxbX7K15J8ZlnSEgS9XEKmMRqzK73csg4J0AygQMnDgVzt4h4iFRERX6gHT6gK1qIddWjVsFghB2nlvflN1PecM9gUuqPl2H/ut16bLNlrxLY5Mm2Xf4nYVvyAx6rEKV/vOrtaquZ9c5tbJr+N4Y/d2mvZzGSzO1kBFl13oEJ7zcTRFMJrg83/CKKCsd3EEP9z6kusBOTfbFdnKW0MjNxD5gzzEsNSet/2NOqtlQB3VIBFFCL19gCpR7HC" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="completed keyexchange" May 20 07:18:36 biuro-it go-librespot[8004]: time="2025-05-20T07:18:36+02:00" level=debug msg="completed challenge" May 20 07:18:37 biuro-it go-librespot[8004]: time="2025-05-20T07:18:37+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:37 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:37 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:37 biuro-it wpa_supplicant[950]: wlan0: Failed to initiate sched scan May 20 07:18:38 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:38 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:39 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:39 biuro-it volumio[1117]: info: Initializing connection to go-librespot Websocket May 20 07:18:39 biuro-it volumio[1117]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 20 07:18:39 biuro-it volumio[1117]: info: Preload queue cleared May 20 07:18:40 biuro-it volumio[1117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 20 07:18:40 biuro-it volumio[1117]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 07:18:40 biuro-it volumio[1117]: TypeError: Cannot read property 'length' of undefined May 20 07:18:40 biuro-it volumio[1117]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 20 07:18:40 biuro-it volumio[1117]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 20 07:18:40 biuro-it volumio[1117]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 20 07:18:40 biuro-it volumio[1117]: at Parser.emit (events.js:315:20) May 20 07:18:40 biuro-it volumio[1117]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 20 07:18:40 biuro-it volumio[1117]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 20 07:18:40 biuro-it volumio[1117]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 20 07:18:40 biuro-it volumio[1117]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 20 07:18:40 biuro-it volumio[1117]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 20 07:18:40 biuro-it volumio[1117]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 20 07:18:40 biuro-it volumio[1117]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 20 07:18:40 biuro-it volumio[1117]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 20 07:18:40 biuro-it volumio[1117]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 20 07:18:40 biuro-it volumio[1117]: at IncomingMessage.emit (events.js:327:22) May 20 07:18:40 biuro-it volumio[1117]: at endReadableNT (internal/streams/readable.js:1327:12) May 20 07:18:40 biuro-it volumio[1117]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 20 07:18:40 biuro-it volumio[1117]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 07:18:40 biuro-it systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 20 07:18:40 biuro-it systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14463. May 20 07:18:40 biuro-it systemd[1]: Stopped go-librespot Daemon. May 20 07:18:40 biuro-it systemd[1]: Started go-librespot Daemon. May 20 07:18:40 biuro-it go-librespot[8030]: go-librespot daemon starting... May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=info msg="running go-librespot 0.2.0" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="app state loaded" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="stored credentials not found" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=info msg="zeroconf server listening on port 42423" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="obtained new client token: AAA8oxs6UK2xWXWn7ACkCCXTzruG0WhoSsPoF2urPKsqTI23U0lQ7m7OPb3N0nq7jIRUov+whoM1xw93bJfntvzRV/IlQeN4x0T6ysaL42MFhprtA8mXesiovlaNCumBehv1gLKh046Yk5hT0qi3mLO4wL5xevcIRAUFZnzxOhrhoatNp1DTUNFvuVaM0Pdik4HJKO78wlZ7NNkVPZK8q/eiuhdWXLzo4FgXG/mfEv7+fsmDvnnmVNsqiDQT" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="completed keyexchange" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=debug msg="completed challenge" May 20 07:18:40 biuro-it go-librespot[8030]: time="2025-05-20T07:18:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials " May 20 07:18:40 biuro-it systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 20 07:18:40 biuro-it systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 20 07:18:40 biuro-it sudo[8048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-20 07:17 May 20 07:18:40 biuro-it sudo[8048]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"