-- Logs begin at Fri 2024-10-25 17:06:12 +03, end at Fri 2024-10-25 17:35:08 +03. -- Oct 25 17:34:02 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:02 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 94. Oct 25 17:34:02 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:02 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:02 allo-revolution go-librespot[730]: Librespot-go daemon starting... Oct 25 17:34:02 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:02 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:02 allo-revolution go-librespot[730]: time="2024-10-25T17:34:02+03:00" level=info msg="generated new device id: 7cd521ef648bf65c0f8a51e943380d17b2d3d780" Oct 25 17:34:02 allo-revolution go-librespot[730]: time="2024-10-25T17:34:02+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:02 allo-revolution go-librespot[730]: time="2024-10-25T17:34:02+03:00" level=debug msg="obtained new client token: AADRgKQItYPAmdUn/FFeNC/SH2iQ1KdjwCxuJd8NFTPsHoK1sSGT7F6ZCZYP1MimiYrk51dIa8/5yIr5KvVNkaMxa2H/ZWBJqYLeayr1/lByn0tIh687Hy2O+1XrflrIOncWVJoiZS+h/ARYF48s6XDudIeNv0p4uPJUy5pOSa4lsj6eQkY2JBXn78T6sfgM+j4nKIIORwK2NKJZcBu1CSJXxB9zZ3zTDG3vCGcd8NhmFV2qyI2OTZeN9uvJxj0Z" Oct 25 17:34:02 allo-revolution go-librespot[730]: time="2024-10-25T17:34:02+03: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]" Oct 25 17:34:03 allo-revolution go-librespot[730]: time="2024-10-25T17:34:03+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:03 allo-revolution go-librespot[730]: time="2024-10-25T17:34:03+03:00" level=debug msg="completed challenge" Oct 25 17:34:03 allo-revolution go-librespot[730]: time="2024-10-25T17:34:03+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:03 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:03 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:05 allo-revolution nmbd[738]: [2024/10/25 17:34:05.400683, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 25 17:34:05 allo-revolution nmbd[738]: wins_write_database: Can't open /var/lib/samba/wins.dat.738: Read-only file system Oct 25 17:34:05 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:05 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:06 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:06 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Oct 25 17:34:06 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:06 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:06 allo-revolution go-librespot[739]: Librespot-go daemon starting... Oct 25 17:34:06 allo-revolution go-librespot[739]: time="2024-10-25T17:34:06+03:00" level=info msg="generated new device id: c765b72b5cef9935a1a033c60ba32b188cd877ed" Oct 25 17:34:06 allo-revolution go-librespot[739]: time="2024-10-25T17:34:06+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:07 allo-revolution go-librespot[739]: time="2024-10-25T17:34:07+03:00" level=debug msg="obtained new client token: AACFFTojtQ742zmFYKVxlvcYzFsZx1TnbaCcRr82vfKzompPlUshNjWKmGHIJVnl8e8fBujIRtfGxFdPchSe47yk/dnnPZ2SacYZc0Lhp3aN8H9K4Kpb6RE5XfWxQ9nwy2Kt+Oy85uVaox88cbwtX5BZWq5R+TjBnJSoOs5At4larGXEs84BVOl+yuJVcez+4vuYsxCGK5SUQOwoY8Hchhnv23W1M5aVkDgk6t1hdojptF9L7LvVEGC1dCVPFs7a" Oct 25 17:34:07 allo-revolution go-librespot[739]: time="2024-10-25T17:34:07+03: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]" Oct 25 17:34:07 allo-revolution go-librespot[739]: time="2024-10-25T17:34:07+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:08 allo-revolution go-librespot[739]: time="2024-10-25T17:34:08+03:00" level=debug msg="completed challenge" Oct 25 17:34:08 allo-revolution go-librespot[739]: time="2024-10-25T17:34:08+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:08 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:08 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:08 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:08 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:10 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 25 17:34:10 allo-revolution volumio[801]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 25 17:34:10 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 25 17:34:10 allo-revolution volumio[801]: info: Received Get System Version Oct 25 17:34:10 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 25 17:34:10 allo-revolution volumio[801]: info: Received Get System Info Oct 25 17:34:10 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 17:34:10 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 17:34:10 allo-revolution volumio[801]: info: Discovery: Getting this device information Oct 25 17:34:10 allo-revolution volumio[801]: info: CoreCommandRouter::volumioGetState Oct 25 17:34:10 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 17:34:11 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:11 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Oct 25 17:34:11 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:11 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:11 allo-revolution go-librespot[747]: Librespot-go daemon starting... Oct 25 17:34:11 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:11 allo-revolution go-librespot[747]: time="2024-10-25T17:34:11+03:00" level=info msg="generated new device id: f87aa5da040ea08bc410f2e9e98432917fa0a6ee" Oct 25 17:34:11 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:11 allo-revolution go-librespot[747]: time="2024-10-25T17:34:11+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:11 allo-revolution go-librespot[747]: time="2024-10-25T17:34:11+03:00" level=debug msg="obtained new client token: AAD4ctdCjcKsIGmDPrhotvbee6Q9vdxHIiB3fHeM2A8cHFDAd53ep+56zWeLMupNMEuNRTw7JPTESn+7NwFch7dmTHG3IQVJH1/Y3r+ePqA0PG+mpRIbdbbHErk1UKxZHESJnu2UUuF8yKf5//ay2cKnFp0HmM2lJjsPxrFjqZLT1Yg9RP+iN+yaDdfuHMudiqMIwwvzhkyeb5rIjrpJ1VJBdc49dWIuLopPH8B3YV1+KLRue6VY3nyL2bGD3/s9" Oct 25 17:34:12 allo-revolution go-librespot[747]: time="2024-10-25T17:34:12+03: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]" Oct 25 17:34:12 allo-revolution go-librespot[747]: time="2024-10-25T17:34:12+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:12 allo-revolution go-librespot[747]: time="2024-10-25T17:34:12+03:00" level=debug msg="completed challenge" Oct 25 17:34:12 allo-revolution go-librespot[747]: time="2024-10-25T17:34:12+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:12 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:12 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:14 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:14 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:15 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:15 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. Oct 25 17:34:15 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:15 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:15 allo-revolution go-librespot[756]: Librespot-go daemon starting... Oct 25 17:34:15 allo-revolution go-librespot[756]: time="2024-10-25T17:34:15+03:00" level=info msg="generated new device id: a24d68a3c288f476bf54fc9cce2abc5c57a92d4c" Oct 25 17:34:15 allo-revolution go-librespot[756]: time="2024-10-25T17:34:15+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:16 allo-revolution go-librespot[756]: time="2024-10-25T17:34:16+03:00" level=debug msg="obtained new client token: AACFqf9wJOfVC+CMhSKepgWQgrphaGLIqz/svKr92mxSbtWZr15fVBs+LOhrb7wRBNAAGqnMAmfjhbDw54h6XgBCnQ5BZoaZ63oE0Vi3JJTPSrxxTo9Vx9ss2FkILeKpDw1dlMWMxMpt/1VjdlPcxFAzV4izgfcBRqONR5U738c5+p/PiMNWisQ/i4kBY22i8huJR9d+jDLXa1w0NYDkK3i7U+Qg40+Q03vBFn7IFdCHafzJ8nf1wvVmVaQoDMXT" Oct 25 17:34:16 allo-revolution go-librespot[756]: time="2024-10-25T17:34:16+03:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 25 17:34:16 allo-revolution go-librespot[756]: time="2024-10-25T17:34:16+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:17 allo-revolution go-librespot[756]: time="2024-10-25T17:34:17+03:00" level=debug msg="completed challenge" Oct 25 17:34:17 allo-revolution go-librespot[756]: time="2024-10-25T17:34:17+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:17 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:17 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:17 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:17 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:17 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 17:34:17 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 17:34:17 allo-revolution volumio[801]: info: Discovery: Getting this device information Oct 25 17:34:17 allo-revolution volumio[801]: info: CoreCommandRouter::volumioGetState Oct 25 17:34:17 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 17:34:20 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:20 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. Oct 25 17:34:20 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:20 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:20 allo-revolution go-librespot[765]: Librespot-go daemon starting... Oct 25 17:34:20 allo-revolution go-librespot[765]: time="2024-10-25T17:34:20+03:00" level=info msg="generated new device id: e1ba518dd349f2c660bef673063945f8b4d3463f" Oct 25 17:34:20 allo-revolution go-librespot[765]: time="2024-10-25T17:34:20+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:20 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:20 allo-revolution go-librespot[765]: time="2024-10-25T17:34:20+03:00" level=debug msg="new websocket client" Oct 25 17:34:20 allo-revolution volumio[801]: info: Connection to go-librespot Websocket established Oct 25 17:34:20 allo-revolution go-librespot[765]: time="2024-10-25T17:34:20+03:00" level=debug msg="obtained new client token: AACXouNnqjysKzQkw1VctAzxHopaCPvPUvzQsgfJSLEYReKRQfrcTxOynmINYdTUdU04k/FKO/yerzrbmi0ZfVqVV9+9TLjMifciyWsV8S8vs2matKUBqQlFWZCFxl3CxVwd1kp95XN789xPDcXS0sRbExhMts3TGHJrCUQf8pqzaG0TT7xLuxFtPO6fOVJGKxkC/D6Um9KxeOS4GsnzVlrx2LGZo9kjM1RZh/P6A7Mm6GjOEBOsZC+Tp963sGhv" Oct 25 17:34:20 allo-revolution go-librespot[765]: time="2024-10-25T17:34:20+03: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]" Oct 25 17:34:21 allo-revolution go-librespot[765]: time="2024-10-25T17:34:21+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:21 allo-revolution go-librespot[765]: time="2024-10-25T17:34:21+03:00" level=debug msg="completed challenge" Oct 25 17:34:21 allo-revolution go-librespot[765]: time="2024-10-25T17:34:21+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:21 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:21 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:21 allo-revolution volumio[801]: info: Connection to go-librespot Websocket closed Oct 25 17:34:21 allo-revolution volumiologrotate[519]: ls: cannot access '/var/log/samba/log.wb-ALLO': No such file or directory Oct 25 17:34:21 allo-revolution volumiologrotate[519]: ls: cannot access 'REVOLUTION': No such file or directory Oct 25 17:34:23 allo-revolution volumio[801]: info: Getting Spotify volume Oct 25 17:34:23 allo-revolution volumio[801]: (node:801) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:23 allo-revolution volumio[801]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 25 17:34:23 allo-revolution volumio[801]: (node:801) 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: 20) Oct 25 17:34:23 allo-revolution volumio[801]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 25 17:34:23 allo-revolution volumio[801]: info: CoreCommandRouter::volumioGetState Oct 25 17:34:24 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:24 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:24 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:24 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Oct 25 17:34:24 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:24 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:24 allo-revolution go-librespot[834]: Librespot-go daemon starting... Oct 25 17:34:24 allo-revolution go-librespot[834]: time="2024-10-25T17:34:24+03:00" level=info msg="generated new device id: e2aa8a6d47d934ce5fb4857141ac7876893faa58" Oct 25 17:34:24 allo-revolution go-librespot[834]: time="2024-10-25T17:34:24+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:25 allo-revolution go-librespot[834]: time="2024-10-25T17:34:25+03:00" level=debug msg="obtained new client token: AAAZSblGAQo/zm2x8jxoeoCoNz6CLEIF860jsfj1dM4nCX3umO2GO2W+iME/7+XCPt+tyWZXLKps501II6Gk/YoCOImAdchFfKRDe/3GFou+kpYKMez0RemNuOATCJUVIKCT3Blbw/eVNNWjAz4J25PLRA8rUIpTHVm+trnVqy+hf4BCf1wHvy6WVFYrUKWPO1IqJTJym94L4b2eOqmx+y/EJ7Y6CdyI+Rx3vl2Ii0geKEhQt26l2UjdKjF+sw==" Oct 25 17:34:25 allo-revolution go-librespot[834]: time="2024-10-25T17:34:25+03: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]" Oct 25 17:34:25 allo-revolution nmbd[842]: [2024/10/25 17:34:25.434262, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 25 17:34:25 allo-revolution nmbd[842]: wins_write_database: Can't open /var/lib/samba/wins.dat.842: Read-only file system Oct 25 17:34:26 allo-revolution go-librespot[834]: time="2024-10-25T17:34:26+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:26 allo-revolution go-librespot[834]: time="2024-10-25T17:34:26+03:00" level=debug msg="completed challenge" Oct 25 17:34:26 allo-revolution go-librespot[834]: time="2024-10-25T17:34:26+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:26 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:26 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:27 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:27 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:29 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:29 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Oct 25 17:34:29 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:29 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:29 allo-revolution go-librespot[843]: Librespot-go daemon starting... Oct 25 17:34:29 allo-revolution go-librespot[843]: time="2024-10-25T17:34:29+03:00" level=info msg="generated new device id: 9efd3610a4049a3c4ba2883d4a5ec5276e9907b4" Oct 25 17:34:29 allo-revolution go-librespot[843]: time="2024-10-25T17:34:29+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:30 allo-revolution go-librespot[843]: time="2024-10-25T17:34:30+03:00" level=debug msg="obtained new client token: AADIktTpz145nn07dq6x4opxavvlyb/yXrLydQrA+4l8UWQWt46r41KVeFnBPlilqQfEJ6j4YccgBVFEHxMGKBzmJOzcqFrUYNIGYm23X0mpviTQWPnBduPPMk/sDdO5YKGIGBWJ80WFAkdVMH8cIrv5GmCLQPRc0IjnSHS83L6HVwjBkLgHj48ULDnkQE+GUKQFQNkxCRaYqsrY2PzQNDNn2wOG2bW2/+cFK6LN35I32ZEq2oXgftYW0sjIgZPN" Oct 25 17:34:30 allo-revolution go-librespot[843]: time="2024-10-25T17:34:30+03:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 25 17:34:30 allo-revolution go-librespot[843]: time="2024-10-25T17:34:30+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:30 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:30 allo-revolution go-librespot[843]: time="2024-10-25T17:34:30+03:00" level=debug msg="new websocket client" Oct 25 17:34:30 allo-revolution volumio[801]: info: Connection to go-librespot Websocket established Oct 25 17:34:31 allo-revolution go-librespot[843]: time="2024-10-25T17:34:31+03:00" level=debug msg="completed challenge" Oct 25 17:34:31 allo-revolution go-librespot[843]: time="2024-10-25T17:34:31+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:31 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:31 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:31 allo-revolution volumio[801]: info: Connection to go-librespot Websocket closed Oct 25 17:34:33 allo-revolution volumio[801]: info: Getting Spotify volume Oct 25 17:34:33 allo-revolution volumio[801]: (node:801) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:33 allo-revolution volumio[801]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 25 17:34:33 allo-revolution volumio[801]: (node:801) 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: 21) Oct 25 17:34:33 allo-revolution volumio[801]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 25 17:34:33 allo-revolution volumio[801]: info: CoreCommandRouter::volumioGetState Oct 25 17:34:34 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:34 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:34 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:34 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Oct 25 17:34:34 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:34 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:34 allo-revolution go-librespot[881]: Librespot-go daemon starting... Oct 25 17:34:34 allo-revolution go-librespot[881]: time="2024-10-25T17:34:34+03:00" level=info msg="generated new device id: e981ee5e4f120d77a8a4b795fb01d1bc70f83a00" Oct 25 17:34:34 allo-revolution go-librespot[881]: time="2024-10-25T17:34:34+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:34 allo-revolution go-librespot[881]: time="2024-10-25T17:34:34+03:00" level=debug msg="obtained new client token: AABaT1Jli+3Qa302S9fZlmWzIq5tcu/VqITeFLU+XFiGtGLlOXNrKQPmRFAt2UcJt65w6mV+T36J4l214JaWfh1TcJn+UW3NM/HA+8ba/H6Lb5jTme3c94NEVHW6pkljz+Zgep+fS6EkTK/ErfR0YLQXq5oyGOVJev0Y1o2e9vVtm+hdIH+O6E7HZfkQsz2L+bqU3UOyNh/X0SB3I7F8AP10Z3n2Wb36xdR3MFya3rPt7CzuW/+Kxw+m+UbTPwsq" Oct 25 17:34:34 allo-revolution go-librespot[881]: time="2024-10-25T17:34:34+03: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]" Oct 25 17:34:35 allo-revolution go-librespot[881]: time="2024-10-25T17:34:35+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:35 allo-revolution go-librespot[881]: time="2024-10-25T17:34:35+03:00" level=debug msg="completed challenge" Oct 25 17:34:35 allo-revolution go-librespot[881]: time="2024-10-25T17:34:35+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:35 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:35 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:37 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:37 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:38 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:38 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Oct 25 17:34:38 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:38 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:38 allo-revolution go-librespot[889]: Librespot-go daemon starting... Oct 25 17:34:38 allo-revolution go-librespot[889]: time="2024-10-25T17:34:38+03:00" level=info msg="generated new device id: 23e13870c043c880866f2fa39eed6c6ed801f6fb" Oct 25 17:34:38 allo-revolution go-librespot[889]: time="2024-10-25T17:34:38+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:39 allo-revolution go-librespot[889]: time="2024-10-25T17:34:39+03:00" level=debug msg="obtained new client token: AAA1wUPFZzxUoWw40kEUUICa2E4ICZp8ucUVf3RMpIL16lqBOOgNgeoNHoJZIVaG1SfEBkMg7lN9g6ofT0IcbZOtquN2XWzifvuEREP+MtlNn8P2mATsh834Wqash4JgBxVyKub8cl3fC8AmtIwSk0lu0/01uAOY8dJyEZ4dPZ1lgcBRE/S49ironw1jdOLNW2ZIEXN/iMxFEIH6SemWtIom8nbY9Z5D3XF1rlsB8zHH9xtPjDy98P/CxM1obA==" Oct 25 17:34:39 allo-revolution go-librespot[889]: time="2024-10-25T17:34:39+03: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]" Oct 25 17:34:39 allo-revolution go-librespot[889]: time="2024-10-25T17:34:39+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:40 allo-revolution go-librespot[889]: time="2024-10-25T17:34:40+03:00" level=debug msg="completed challenge" Oct 25 17:34:40 allo-revolution go-librespot[889]: time="2024-10-25T17:34:40+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:40 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:40 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:40 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:40 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:43 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:43 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:43 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:43 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Oct 25 17:34:43 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:43 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:43 allo-revolution go-librespot[897]: Librespot-go daemon starting... Oct 25 17:34:43 allo-revolution go-librespot[897]: time="2024-10-25T17:34:43+03:00" level=info msg="generated new device id: 68058042f959fe6535025d10655b7a33093504ea" Oct 25 17:34:43 allo-revolution go-librespot[897]: time="2024-10-25T17:34:43+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:43 allo-revolution go-librespot[897]: time="2024-10-25T17:34:43+03:00" level=debug msg="obtained new client token: AACc7AYcSo4CbdjFQkIGOwvSCLdrYZPBgN2UEvPPnjZ2hl/bWkBq+q1Yt7a/hB9Vq++0t8+mdKhTdPNMTHR4goaq8HBY50JD8SxizOiauho770K6ZKOtYo/3qEpp1VzAeXlid1zEA+zSQuEWrbFdS+P8LP9YNejjhLB/B4HpcyXKNGicbRYwR+C13hvHuYQ+QN/uZEmd3rv+4370HmnzgAMRMKYuZ5SaCa9aXJ4akBjCembGaQa0QstNs0sUBgmR" Oct 25 17:34:43 allo-revolution go-librespot[897]: time="2024-10-25T17:34:43+03: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]" Oct 25 17:34:44 allo-revolution go-librespot[897]: time="2024-10-25T17:34:44+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:44 allo-revolution go-librespot[897]: time="2024-10-25T17:34:44+03:00" level=debug msg="completed challenge" Oct 25 17:34:44 allo-revolution go-librespot[897]: time="2024-10-25T17:34:44+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:44 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:44 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:45 allo-revolution nmbd[913]: [2024/10/25 17:34:45.467988, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 25 17:34:45 allo-revolution nmbd[913]: wins_write_database: Can't open /var/lib/samba/wins.dat.913: Read-only file system Oct 25 17:34:46 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:46 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:47 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 17:34:47 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 17:34:47 allo-revolution volumio[801]: info: Discovery: Getting this device information Oct 25 17:34:47 allo-revolution volumio[801]: info: CoreCommandRouter::volumioGetState Oct 25 17:34:47 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 17:34:47 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:47 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Oct 25 17:34:47 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:47 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:47 allo-revolution go-librespot[914]: Librespot-go daemon starting... Oct 25 17:34:47 allo-revolution go-librespot[914]: time="2024-10-25T17:34:47+03:00" level=info msg="generated new device id: b23651dc5da428f90a73bf91293f18ba9037117e" Oct 25 17:34:47 allo-revolution go-librespot[914]: time="2024-10-25T17:34:47+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:48 allo-revolution go-librespot[914]: time="2024-10-25T17:34:48+03:00" level=debug msg="obtained new client token: AABEwWMpqHikyO1gG++BolBQoNiULszsqPC8JTUZN8glJnddGrOc3CzIpYQDO+cQ2RmgLjGzJBR6dHWdHD033MdWQ3SOHBPZnwqA3ITIuqZ6e6fwtkREHDo8730GQLofYMpDIQUMrkH3iHZN4wi8j1eZ/SD3bGV0moI+H8mFQqVLkehHofcc7eD1OTsMTemIte95qeViaSbvioMJVBhRJWcc1Hm4kq4pLedbF2utWus5unx1/ja4syID1i3Ed/K6" Oct 25 17:34:48 allo-revolution go-librespot[914]: time="2024-10-25T17:34:48+03: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]" Oct 25 17:34:48 allo-revolution go-librespot[914]: time="2024-10-25T17:34:48+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:49 allo-revolution go-librespot[914]: time="2024-10-25T17:34:49+03:00" level=debug msg="completed challenge" Oct 25 17:34:49 allo-revolution go-librespot[914]: time="2024-10-25T17:34:49+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:49 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:49 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:49 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:49 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:51 allo-revolution volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 17:34:51 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 25 17:34:51 allo-revolution kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #1115597: comm node: reading directory lblock 0 Oct 25 17:34:51 allo-revolution kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #1122435: comm sh: reading directory lblock 0 Oct 25 17:34:51 allo-revolution volumio[801]: /bin/sh: 1: /bin/lsblk: Input/output error Oct 25 17:34:51 allo-revolution volumio[801]: error: Command failed: /bin/lsblk -P -o KNAME,SIZE,MODEL -d Oct 25 17:34:51 allo-revolution volumio[801]: /bin/sh: 1: /bin/lsblk: Input/output error Oct 25 17:34:51 allo-revolution volumio[801]: {"status":2,"signal":null,"output":[null,"","/bin/sh: 1: /bin/lsblk: Input/output error\n"],"pid":928,"stdout":"","stderr":"/bin/sh: 1: /bin/lsblk: Input/output error\n"} Oct 25 17:34:51 allo-revolution kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #1115562: comm sh: reading directory lblock 0 Oct 25 17:34:52 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:52 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:52 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:52 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Oct 25 17:34:52 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:52 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:52 allo-revolution go-librespot[930]: Librespot-go daemon starting... Oct 25 17:34:52 allo-revolution go-librespot[930]: time="2024-10-25T17:34:52+03:00" level=info msg="generated new device id: 7d2550bfd16684d07ba226bf9851ff0ff136f7ba" Oct 25 17:34:52 allo-revolution go-librespot[930]: time="2024-10-25T17:34:52+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:52 allo-revolution go-librespot[930]: time="2024-10-25T17:34:52+03:00" level=debug msg="obtained new client token: AADijosjhtkayrJh/DnwYjd49A4ZH1sJ0lk1wmtAF/chBSkdmVZhH2QUR4jiDjj8Nijy2E87vt8AT37MQ3j998Xpbm9p5WGjHjWyFVOHZBJYks1rUF2o76Mw3pUFH10hSjiVkOS1Y1ItBNQynVeM0PUQkcHReP2w1EgbtqII3OdHYVN3KIz6M+u+arGU1thE/9P9p2hCkYhIeoSOCDOzMbGwrr0yd4GC02ASFqHA8YYC/UQ+B8ByNnhLyI1VOydC" Oct 25 17:34:52 allo-revolution go-librespot[930]: time="2024-10-25T17:34:52+03:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 25 17:34:53 allo-revolution go-librespot[930]: time="2024-10-25T17:34:53+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:53 allo-revolution go-librespot[930]: time="2024-10-25T17:34:53+03:00" level=debug msg="completed challenge" Oct 25 17:34:53 allo-revolution go-librespot[930]: time="2024-10-25T17:34:53+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:53 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:53 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:55 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:55 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:34:56 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:34:56 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Oct 25 17:34:56 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:34:56 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:34:56 allo-revolution go-librespot[942]: Librespot-go daemon starting... Oct 25 17:34:56 allo-revolution go-librespot[942]: time="2024-10-25T17:34:56+03:00" level=info msg="generated new device id: 67de67e52e694a6f97ccf5a488c27d066edb08cd" Oct 25 17:34:56 allo-revolution go-librespot[942]: time="2024-10-25T17:34:56+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:34:57 allo-revolution go-librespot[942]: time="2024-10-25T17:34:57+03:00" level=debug msg="obtained new client token: AAC9wccXvsgeApztkR6rtGMH1wPZxh/vUenudFDX5nF4brAi/jki5mJS1xJGBEb+v37kSnqjkZHsURCb7KVE6er0B9kAXhGFAHycer2N3TyoH8Thg2WC0mNNaEptX0bCm007BeRzT6Khb5joeJR9+LWpOsFIFw3gEj+O6beoWXcVIjx1h62LZR/IGHnXL3GP+8I9XVvwzOOkFDZLc9jTOx7onleqtrjfYK+OR9Ul1XpKRI0MgK11ZwGEoCn9AQ==" Oct 25 17:34:57 allo-revolution go-librespot[942]: time="2024-10-25T17:34:57+03: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]" Oct 25 17:34:57 allo-revolution go-librespot[942]: time="2024-10-25T17:34:57+03:00" level=debug msg="completed keyexchange" Oct 25 17:34:58 allo-revolution go-librespot[942]: time="2024-10-25T17:34:58+03:00" level=debug msg="completed challenge" Oct 25 17:34:58 allo-revolution go-librespot[942]: time="2024-10-25T17:34:58+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:34:58 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:34:58 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:34:58 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:34:58 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:35:01 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:35:01 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:35:01 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:35:01 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Oct 25 17:35:01 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:35:01 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:35:01 allo-revolution go-librespot[950]: Librespot-go daemon starting... Oct 25 17:35:01 allo-revolution go-librespot[950]: time="2024-10-25T17:35:01+03:00" level=info msg="generated new device id: beb9aa6d5d00fde691636bba153e173597fc8667" Oct 25 17:35:01 allo-revolution go-librespot[950]: time="2024-10-25T17:35:01+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:35:01 allo-revolution go-librespot[950]: time="2024-10-25T17:35:01+03:00" level=debug msg="obtained new client token: AAAaWJcRkxmcKEbTjw3zxUzMO7YvCPm+uNVtTy6QxOxx5RVIqkOS+EWnX1HCnoz7B08nVtF/2gqyVeYa5xPRNPlTaleDXfohchj+pbHveck3xo1fFVx5zWF9NLZz8IT6lBDmKv7KYvuT4t1p3ztxaVY4W/NQE+LOpgK9y43UjM2AX4c8nBtordL8OOiEsTFDqS9E8fTh7cdNaLh4cBDxca4W7sKlmenApsr5G1OdDldZlHMmUXEb5MN/3i29hsI/" Oct 25 17:35:01 allo-revolution go-librespot[950]: time="2024-10-25T17:35:01+03: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]" Oct 25 17:35:02 allo-revolution go-librespot[950]: time="2024-10-25T17:35:02+03:00" level=debug msg="completed keyexchange" Oct 25 17:35:02 allo-revolution go-librespot[950]: time="2024-10-25T17:35:02+03:00" level=debug msg="completed challenge" Oct 25 17:35:02 allo-revolution go-librespot[950]: time="2024-10-25T17:35:02+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:35:02 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:35:02 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:35:04 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:35:04 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 17:35:05 allo-revolution nmbd[959]: [2024/10/25 17:35:05.502691, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Oct 25 17:35:05 allo-revolution nmbd[959]: wins_write_database: Can't open /var/lib/samba/wins.dat.959: Read-only file system Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 25 17:35:05 allo-revolution kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #1148414: lblock 0: comm aplay: error -5 reading directory block Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 25 17:35:05 allo-revolution volumio[801]: Invalid card number. Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 25 17:35:05 allo-revolution volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 25 17:35:05 allo-revolution systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 25 17:35:05 allo-revolution systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Oct 25 17:35:05 allo-revolution systemd[1]: Stopped go-librespot Daemon. Oct 25 17:35:05 allo-revolution systemd[1]: Started go-librespot Daemon. Oct 25 17:35:05 allo-revolution go-librespot[963]: Librespot-go daemon starting... Oct 25 17:35:05 allo-revolution go-librespot[963]: time="2024-10-25T17:35:05+03:00" level=info msg="generated new device id: 5a1f641d2d2b8ae90e4441d25fd594a48347e60f" Oct 25 17:35:05 allo-revolution go-librespot[963]: time="2024-10-25T17:35:05+03:00" level=debug msg="stored credentials found for cbo354oixm8wgd4oydcrfal5p" Oct 25 17:35:06 allo-revolution go-librespot[963]: time="2024-10-25T17:35:06+03:00" level=debug msg="obtained new client token: AADYABdOZRA78wtAE4Sa/dZJwWx9TeikzEEd+cn1eG5XzeS30LgJAOROlfjb8rhkkFphBY2mCMfySq6r+Gr8OYBqReiJsfD90E+DQfFxOSsG3625ep0nxeFoflBMrgAYLY+DbrE/FNItcNDUBkRFVO57Z6RT17aZ2s5H+/zey5ykI9l/uh3cIQxIgjWWIPOwVPODOslqd1awDBKWxFrCw5rzscBweZnijzsDvxsMfmoWgXDdh+MbGVHfoAcUhvs7" Oct 25 17:35:06 allo-revolution go-librespot[963]: time="2024-10-25T17:35:06+03:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 25 17:35:06 allo-revolution go-librespot[963]: time="2024-10-25T17:35:06+03:00" level=debug msg="completed keyexchange" Oct 25 17:35:07 allo-revolution go-librespot[963]: time="2024-10-25T17:35:07+03:00" level=debug msg="completed challenge" Oct 25 17:35:07 allo-revolution go-librespot[963]: time="2024-10-25T17:35:07+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Oct 25 17:35:07 allo-revolution systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 25 17:35:07 allo-revolution systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 25 17:35:07 allo-revolution volumio[801]: info: Initializing connection to go-librespot Websocket Oct 25 17:35:07 allo-revolution volumio[801]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 25 17:35:07 allo-revolution volumio[801]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 17:35:07 allo-revolution kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #1115623: lblock 0: comm node: error -5 reading directory block Oct 25 17:35:07 allo-revolution volumio[801]: Error: EIO: i/o error, scandir '/data/plugins/' Oct 25 17:35:07 allo-revolution volumio[801]: at Object.readdirSync (fs.js:1021:3) Oct 25 17:35:07 allo-revolution volumio[801]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30) Oct 25 17:35:07 allo-revolution volumio[801]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1521:29) Oct 25 17:35:07 allo-revolution volumio[801]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1328:45) Oct 25 17:35:07 allo-revolution volumio[801]: at Socket.emit (events.js:315:20) Oct 25 17:35:07 allo-revolution volumio[801]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 25 17:35:07 allo-revolution volumio[801]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 25 17:35:07 allo-revolution volumio[801]: errno: -5, Oct 25 17:35:07 allo-revolution volumio[801]: syscall: 'scandir', Oct 25 17:35:07 allo-revolution volumio[801]: code: 'EIO', Oct 25 17:35:07 allo-revolution volumio[801]: path: '/data/plugins/' Oct 25 17:35:07 allo-revolution volumio[801]: } Oct 25 17:35:07 allo-revolution volumio[801]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 17:35:08 allo-revolution sudo[980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-25 17:34 Oct 25 17:35:08 allo-revolution sudo[980]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"