-- Logs begin at Tue 2024-12-24 02:39:06 +07, end at Tue 2024-12-24 02:47:34 +07. -- Dec 24 02:46:00 volumio volumio[5333]: info: Getting Spotify volume Dec 24 02:46:00 volumio volumio[5333]: (node:5333) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:00 volumio volumio[5333]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) Dec 24 02:46:00 volumio volumio[5333]: (node:5333) 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: 10) Dec 24 02:46:00 volumio volumio[5333]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Dec 24 02:46:00 volumio volumio[5333]: info: CoreCommandRouter::volumioGetState Dec 24 02:46:00 volumio volumio[5333]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Dec 24 02:46:00 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:00 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:00 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Dec 24 02:46:00 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:00 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:00 volumio go-librespot[10640]: Librespot-go daemon starting... Dec 24 02:46:00 volumio go-librespot[10640]: time="2024-12-24T02:46:00+07:00" level=info msg="generated new device id: fd7930075b536e40fb4635325860f8dd7d012a75" Dec 24 02:46:00 volumio go-librespot[10640]: time="2024-12-24T02:46:00+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:00 volumio go-librespot[10640]: time="2024-12-24T02:46:00+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:00+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:03 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:03 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:03 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Dec 24 02:46:03 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:03 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:03 volumio go-librespot[10696]: Librespot-go daemon starting... Dec 24 02:46:04 volumio go-librespot[10696]: time="2024-12-24T02:46:04+07:00" level=info msg="generated new device id: 405f50010f27f77a14684932ec1cd5e39e4f98fa" Dec 24 02:46:04 volumio go-librespot[10696]: time="2024-12-24T02:46:04+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:04 volumio go-librespot[10696]: time="2024-12-24T02:46:04+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:04+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:06 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:06 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:07 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. Dec 24 02:46:07 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:07 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:07 volumio go-librespot[10742]: Librespot-go daemon starting... Dec 24 02:46:07 volumio go-librespot[10742]: time="2024-12-24T02:46:07+07:00" level=info msg="generated new device id: 1065781b15d2292ff85cd7a00cdfd402781b2303" Dec 24 02:46:07 volumio go-librespot[10742]: time="2024-12-24T02:46:07+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:07 volumio go-librespot[10742]: time="2024-12-24T02:46:07+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:07+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:09 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:09 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. Dec 24 02:46:10 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:10 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:10 volumio go-librespot[10799]: Librespot-go daemon starting... Dec 24 02:46:10 volumio go-librespot[10799]: time="2024-12-24T02:46:10+07:00" level=info msg="generated new device id: 1f88b65c74864cd4377621c9de838109907bbce2" Dec 24 02:46:10 volumio go-librespot[10799]: time="2024-12-24T02:46:10+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:11 volumio go-librespot[10799]: time="2024-12-24T02:46:11+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:11+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:12 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:12 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:14 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Dec 24 02:46:14 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:14 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:14 volumio go-librespot[10847]: Librespot-go daemon starting... Dec 24 02:46:14 volumio go-librespot[10847]: time="2024-12-24T02:46:14+07:00" level=info msg="generated new device id: 207f2236bf47e11a04cbbb84f3ea62a89f438d01" Dec 24 02:46:14 volumio go-librespot[10847]: time="2024-12-24T02:46:14+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:14 volumio go-librespot[10847]: time="2024-12-24T02:46:14+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:14+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:15 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:15 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:17 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Dec 24 02:46:17 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:17 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:17 volumio go-librespot[10904]: Librespot-go daemon starting... Dec 24 02:46:17 volumio go-librespot[10904]: time="2024-12-24T02:46:17+07:00" level=info msg="generated new device id: 236bfda4026f6ec93107ea2a4c5e6b44bbe4b224" Dec 24 02:46:18 volumio go-librespot[10904]: time="2024-12-24T02:46:18+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:18 volumio go-librespot[10904]: time="2024-12-24T02:46:18+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:18+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:18 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:18 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:19 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 24 02:46:19 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 24 02:46:21 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:21 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Dec 24 02:46:21 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:21 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:21 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:21 volumio go-librespot[10952]: Librespot-go daemon starting... Dec 24 02:46:21 volumio go-librespot[10952]: time="2024-12-24T02:46:21+07:00" level=info msg="generated new device id: 8a19ee4f0e4d72e8c36e3dd4252931d8046315ab" Dec 24 02:46:21 volumio go-librespot[10952]: time="2024-12-24T02:46:21+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:21 volumio go-librespot[10952]: time="2024-12-24T02:46:21+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:21+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:22 volumio volumio[5333]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 24 02:46:24 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:24 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:24 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Dec 24 02:46:24 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:24 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:24 volumio go-librespot[11009]: Librespot-go daemon starting... Dec 24 02:46:24 volumio go-librespot[11009]: time="2024-12-24T02:46:24+07:00" level=info msg="generated new device id: e20ca508ce67bc72b1d208caaff3a1199440e0ee" Dec 24 02:46:24 volumio go-librespot[11009]: time="2024-12-24T02:46:24+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:25 volumio go-librespot[11009]: time="2024-12-24T02:46:25+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:25+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:27 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:27 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:28 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Dec 24 02:46:28 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:28 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:28 volumio go-librespot[11057]: Librespot-go daemon starting... Dec 24 02:46:28 volumio go-librespot[11057]: time="2024-12-24T02:46:28+07:00" level=info msg="generated new device id: beeab0b6cf2004a400960b2d3e15ddebd9887e1e" Dec 24 02:46:28 volumio go-librespot[11057]: time="2024-12-24T02:46:28+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:28 volumio go-librespot[11057]: time="2024-12-24T02:46:28+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:28+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:30 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:30 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:31 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Dec 24 02:46:31 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:31 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:31 volumio go-librespot[11129]: Librespot-go daemon starting... Dec 24 02:46:31 volumio go-librespot[11129]: time="2024-12-24T02:46:31+07:00" level=info msg="generated new device id: 4e9d0d5968e693c1fd12004048f390da24c8a7fa" Dec 24 02:46:32 volumio go-librespot[11129]: time="2024-12-24T02:46:32+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:32 volumio go-librespot[11129]: time="2024-12-24T02:46:32+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:32+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:33 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:33 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:35 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Dec 24 02:46:35 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:35 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:35 volumio go-librespot[11180]: Librespot-go daemon starting... Dec 24 02:46:35 volumio go-librespot[11180]: time="2024-12-24T02:46:35+07:00" level=info msg="generated new device id: 7f701ad2a9c5c74b69aea8af450416e91a08fa2c" Dec 24 02:46:35 volumio go-librespot[11180]: time="2024-12-24T02:46:35+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:35 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 24 02:46:35 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 24 02:46:35 volumio go-librespot[11180]: time="2024-12-24T02:46:35+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:35+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:36 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:36 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:38 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Dec 24 02:46:38 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:38 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:38 volumio go-librespot[11210]: Librespot-go daemon starting... Dec 24 02:46:38 volumio go-librespot[11210]: time="2024-12-24T02:46:38+07:00" level=info msg="generated new device id: 524031d15a22644f7dc265adf8aa823ba8292468" Dec 24 02:46:38 volumio go-librespot[11210]: time="2024-12-24T02:46:38+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:39 volumio go-librespot[11210]: time="2024-12-24T02:46:39+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:39+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:39 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:39 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:42 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Dec 24 02:46:42 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:42 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:42 volumio go-librespot[11258]: Librespot-go daemon starting... Dec 24 02:46:42 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:42 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:42 volumio go-librespot[11258]: time="2024-12-24T02:46:42+07:00" level=info msg="generated new device id: 64ace805b0d8f379752dff2fbee73e942ca42b04" Dec 24 02:46:42 volumio go-librespot[11258]: time="2024-12-24T02:46:42+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:42 volumio go-librespot[11258]: time="2024-12-24T02:46:42+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:42+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:45 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:45 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:45 volumio volumio[5333]: info: VolumeController::SetAlsaVolume40 Dec 24 02:46:45 volumio volumio[5333]: info: CoreCommandRouter::volumioGetState Dec 24 02:46:45 volumio volumio[5333]: info: CoreStateMachine::pushState Dec 24 02:46:45 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 24 02:46:45 volumio volumio[5333]: info: CoreCommandRouter::volumioPushState Dec 24 02:46:45 volumio volumio[5333]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Dec 24 02:46:45 volumio volumio[5333]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Dec 24 02:46:45 volumio volumio[5333]: SPOTIFY: SPOTIFY VOLUME 50 Dec 24 02:46:45 volumio volumio[5333]: SPOTIFY: VOLUMIO VOLUME 40 Dec 24 02:46:45 volumio volumio[5333]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 24 02:46:45 volumio volumio[5333]: info: Setting Spotify Volume from Volumio: 40 Dec 24 02:46:45 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Dec 24 02:46:45 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:45 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:45 volumio go-librespot[11332]: Librespot-go daemon starting... Dec 24 02:46:45 volumio go-librespot[11332]: time="2024-12-24T02:46:45+07:00" level=info msg="generated new device id: 62da9a3bf2bf1584433a5085a697987cd1dbbe04" Dec 24 02:46:45 volumio go-librespot[11332]: time="2024-12-24T02:46:45+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:46 volumio go-librespot[11332]: time="2024-12-24T02:46:46+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:46+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:47 volumio volumio[5333]: SPOTIFY: SETTING SPOTIFY VOLUME 40 Dec 24 02:46:47 volumio volumio[5333]: info: Sending Spotify command with payload to local API: /player/volume Dec 24 02:46:47 volumio volumio[5333]: error: Failed to send command to Spotify local API: /player/volume: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:48 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:48 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:49 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Dec 24 02:46:49 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:49 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:49 volumio go-librespot[11362]: Librespot-go daemon starting... Dec 24 02:46:49 volumio go-librespot[11362]: time="2024-12-24T02:46:49+07:00" level=info msg="generated new device id: ba7715383b70790fada4e11636cd6ce9a280c8a3" Dec 24 02:46:49 volumio go-librespot[11362]: time="2024-12-24T02:46:49+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:49 volumio volumio[5333]: info: CoreCommandRouter::volumioPause Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::pause Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::stPlaybackTimer Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::servicePause Dec 24 02:46:49 volumio volumio[5333]: info: CorePlayQueue::getTrack 0 Dec 24 02:46:49 volumio volumio[5333]: info: CoreCommandRouter::servicePause Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 24 02:46:49 volumio volumio[5333]: info: ControllerMpd::pause Dec 24 02:46:49 volumio volumio[5333]: verbose: ControllerMpd::sendMpdCommand pause Dec 24 02:46:49 volumio volumio[5333]: info: sendMpdCommand pause took 16 milliseconds Dec 24 02:46:49 volumio volumio[5333]: info: Dec 24 02:46:49 volumio volumio[5333]: ---------------------------- MPD announces state update: player Dec 24 02:46:49 volumio volumio[5333]: info: ControllerMpd::getState Dec 24 02:46:49 volumio volumio[5333]: verbose: ControllerMpd::sendMpdCommand status Dec 24 02:46:49 volumio volumio[5333]: info: sendMpdCommand status took 3 milliseconds Dec 24 02:46:49 volumio volumio[5333]: verbose: ControllerMpd::parseState Dec 24 02:46:49 volumio volumio[5333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 24 02:46:49 volumio volumio[5333]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 24 02:46:49 volumio volumio[5333]: verbose: ControllerMpd::parseTrackInfo Dec 24 02:46:49 volumio volumio[5333]: info: ControllerMpd::pushState Dec 24 02:46:49 volumio volumio[5333]: info: CoreCommandRouter::servicePushState Dec 24 02:46:49 volumio volumio[5333]: info: CorePlayQueue::getTrack 0 Dec 24 02:46:49 volumio volumio[5333]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":61100,"duration":248,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BOYNEXTDOOR (보이넥스트도어) '오늘만 I LOVE YOU' Official MV","artist":"HYBE LABELS","album":"YouTube","uri":"https://rr12---sn-8qj-i5ozd.googlevideo.com/videoplayback?expire=1736555129&ei=GGaBZ9XEPL-U1d8PmbrL8Qs&ip=14.231.191.225&id=o-AExjVcgr7WuCCYvLupEYhylmPvQ58bMat3ML718H-fD7&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1736533528%2C&mh=TI&mm=31%2C29&mn=sn-8qj-i5ozd%2Csn-8qj-i5o66&ms=au%2Crdu&mv=m&mvi=12&pl=21&rms=au%2Cau&initcwndbps=253750&bui=AY2Et-MNjb86GkPH4WHx6Jb4apJ02YgmDPH28cb1cBO3i9FO0N_Gz5xBGpV0cFkQSTpcrynLmKhKJcoU&spc=9kzgDTzLoE5HGQULgIJ-lHP98wTQ9WWU-AGO67Vaddk4fVl9i0_fE1yth3bMucM&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=9gQOybL_y_YsgX7CJZ5rYCoQ&rqh=1&gir=yes&clen=3960277&dur=248.281&lmt=1736286584433147&mt=1736533044&fvip=1&keepalive=yes&fexp=51326932%2C51335594%2C51353498%2C51355912%2C51371294&c=WEB&sefc=1&txp=4532034&n=WN-HH9MsnRUnHA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=AGluJ3MwRQIgUWwWfdEA60Iw8R3d8D3x5b7CrbGZMfjRWT7sevTLbDwCIQD2VcG34UnzXt5wG-2SUwF6eUwbm7vxT53M9LNQP6Vc6g%3D%3D&sig=AJfQdSswRAIgfYDQwv7ATr9_T9JNZENVYkcYG-V1Px5QzodQfxI7k5MCIDIMezk-sdbekzznvjMZD-jAnZFuDEJ6D1giFkRFm_m1&pot=Mnj8CPHxiQ-prfw0YqhE_DbSA4ciZ327hHIMXMAWKGufEmqw7hjXwYVBue_mPljyOic34uYungIYXyC65ethQfejc9TMs8UAYa6vx-Zx6Onl236cU8ziwvZ5yQzaWj2aeJcxa-BJJdGv1KGFHN925KYrf8l4odR1eTE%3D&cver=2.20241121.01.00&t.YouTube","trackType":"YouTube"} Dec 24 02:46:49 volumio volumio[5333]: verbose: CURRENT POSITION 0 Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::syncState stateService pause Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::syncState currentStatus pause Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::pushState Dec 24 02:46:49 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 24 02:46:49 volumio volumio[5333]: info: CoreCommandRouter::volumioPushState Dec 24 02:46:49 volumio volumio[5333]: info: CoreStateMachine::stPlaybackTimer Dec 24 02:46:49 volumio volumio[5333]: info: ------------------------------ 41ms Dec 24 02:46:49 volumio volumio[5333]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Dec 24 02:46:49 volumio go-librespot[11362]: time="2024-12-24T02:46:49+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:49+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:51 volumio ntpd[4947]: Soliciting pool server 103.199.19.135 Dec 24 02:46:51 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:51 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:46:52 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:46:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Dec 24 02:46:52 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:46:52 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:46:52 volumio go-librespot[11419]: Librespot-go daemon starting... Dec 24 02:46:52 volumio go-librespot[11419]: time="2024-12-24T02:46:52+07:00" level=info msg="generated new device id: 5f7b52b6938b2eab062af9c75fd4e2ce0a25578b" Dec 24 02:46:52 volumio go-librespot[11419]: time="2024-12-24T02:46:52+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:46:54 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:46:54 volumio go-librespot[11419]: time="2024-12-24T02:46:54+07:00" level=debug msg="new websocket client" Dec 24 02:46:54 volumio volumio[5333]: info: Connection to go-librespot Websocket established Dec 24 02:46:55 volumio ntpd[4947]: Soliciting pool server 2a0c:b847:ffff:79::e53c Dec 24 02:46:57 volumio volumio[5333]: info: Getting Spotify volume Dec 24 02:46:57 volumio volumio[5333]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Dec 24 02:46:57 volumio volumio[5333]: info: CoreCommandRouter::volumioGetState Dec 24 02:46:57 volumio volumio[5333]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Dec 24 02:46:58 volumio go-librespot[11419]: time="2024-12-24T02:46:58+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:46:58+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:46:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:46:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:46:58 volumio volumio[5333]: (node:5333) UnhandledPromiseRejectionWarning: Error: socket hang up Dec 24 02:46:58 volumio volumio[5333]: at connResetException (internal/errors.js:639:14) Dec 24 02:46:58 volumio volumio[5333]: at Socket.socketOnEnd (_http_client.js:499:23) Dec 24 02:46:58 volumio volumio[5333]: at Socket.emit (events.js:412:35) Dec 24 02:46:58 volumio volumio[5333]: at endReadableNT (internal/streams/readable.js:1334:12) Dec 24 02:46:58 volumio volumio[5333]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Dec 24 02:46:58 volumio volumio[5333]: (node:5333) 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: 11) Dec 24 02:46:58 volumio volumio[5333]: info: Connection to go-librespot Websocket closed Dec 24 02:47:00 volumio ntpd[4947]: Soliciting pool server 27.71.27.209 Dec 24 02:47:01 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:01 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:01 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Dec 24 02:47:01 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:01 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:01 volumio go-librespot[11472]: Librespot-go daemon starting... Dec 24 02:47:01 volumio go-librespot[11472]: time="2024-12-24T02:47:01+07:00" level=info msg="generated new device id: 6f583e084d1135548443ea95d827e505c9edae51" Dec 24 02:47:01 volumio go-librespot[11472]: time="2024-12-24T02:47:01+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:01 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Dec 24 02:47:01 volumio volumio[5333]: info: [youtube2-browse] browseUri: youtube2/subscriptions@endpoint:o=%7B%22type%22%3A%22browse%22%2C%22payload%22%3A%7B%22browseId%22%3A%22FEsubscriptions%22%7D%7D Dec 24 02:47:01 volumio volumio[5333]: error: You need to be signed in to access this content. You can do this in the plugin settings. Error: You need to be signed in to access this content. You can do this in the plugin settings. Dec 24 02:47:01 volumio volumio[5333]: at SubscriptionsViewHandler.browse (/data/plugins/music_service/youtube2/dist/lib/controller/browse/view-handlers/GenericViewHandler.js:36:19) Dec 24 02:47:01 volumio volumio[5333]: at runMicrotasks () Dec 24 02:47:01 volumio volumio[5333]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Dec 24 02:47:01 volumio volumio[5333]: at async BrowseController.browseUri (/data/plugins/music_service/youtube2/dist/lib/controller/browse/index.js:35:20) Dec 24 02:47:01 volumio volumio[5333]: error: Failed to execute browseSource: Error: You need to be signed in to access this content. You can do this in the plugin settings. Dec 24 02:47:01 volumio go-librespot[11472]: time="2024-12-24T02:47:01+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:01+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:02 volumio ntpd[4947]: Soliciting pool server 115.165.161.155 Dec 24 02:47:04 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:04 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:04 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Dec 24 02:47:04 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:04 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:04 volumio go-librespot[11510]: Librespot-go daemon starting... Dec 24 02:47:04 volumio go-librespot[11510]: time="2024-12-24T02:47:04+07:00" level=info msg="generated new device id: 324bc9ba4dd63558ad2ea4b4fd45c9c91a5e94c1" Dec 24 02:47:04 volumio go-librespot[11510]: time="2024-12-24T02:47:04+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:05 volumio go-librespot[11510]: time="2024-12-24T02:47:05+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:05+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:05 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri Dec 24 02:47:05 volumio volumio[5333]: info: [youtube2-browse] browseUri: youtube2 Dec 24 02:47:07 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:07 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:08 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Dec 24 02:47:08 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:08 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:08 volumio go-librespot[11558]: Librespot-go daemon starting... Dec 24 02:47:08 volumio go-librespot[11558]: time="2024-12-24T02:47:08+07:00" level=info msg="generated new device id: f49442dec5c70480b055f75de656b2e2b9ccfee3" Dec 24 02:47:08 volumio go-librespot[11558]: time="2024-12-24T02:47:08+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:08 volumio go-librespot[11558]: time="2024-12-24T02:47:08+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:08+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:09 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 24 02:47:09 volumio volumio[5333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 24 02:47:10 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:10 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:11 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Dec 24 02:47:11 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:11 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:11 volumio go-librespot[11611]: Librespot-go daemon starting... Dec 24 02:47:11 volumio go-librespot[11611]: time="2024-12-24T02:47:11+07:00" level=info msg="generated new device id: f1fb4e89e74a53ba77c0ed233598f41c021ddc46" Dec 24 02:47:11 volumio go-librespot[11611]: time="2024-12-24T02:47:11+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:12 volumio go-librespot[11611]: time="2024-12-24T02:47:12+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:12+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:13 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:13 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:15 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Dec 24 02:47:15 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:15 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:15 volumio go-librespot[11660]: Librespot-go daemon starting... Dec 24 02:47:15 volumio go-librespot[11660]: time="2024-12-24T02:47:15+07:00" level=info msg="generated new device id: af30e2cfc0e206ff646ee27cb146afec03bfb350" Dec 24 02:47:15 volumio go-librespot[11660]: time="2024-12-24T02:47:15+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:15 volumio go-librespot[11660]: time="2024-12-24T02:47:15+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:15+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:16 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:16 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Dec 24 02:47:18 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:18 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:18 volumio go-librespot[11716]: Librespot-go daemon starting... Dec 24 02:47:18 volumio go-librespot[11716]: time="2024-12-24T02:47:18+07:00" level=info msg="generated new device id: 8721e561911f7a816113e8eafc1b6ac4908d70dd" Dec 24 02:47:18 volumio go-librespot[11716]: time="2024-12-24T02:47:18+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:19 volumio go-librespot[11716]: time="2024-12-24T02:47:19+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:19+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:19 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:19 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:22 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Dec 24 02:47:22 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:22 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:22 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:22 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:22 volumio go-librespot[11764]: Librespot-go daemon starting... Dec 24 02:47:22 volumio go-librespot[11764]: time="2024-12-24T02:47:22+07:00" level=info msg="generated new device id: 4179e37aaa3fdf2f5abeab0cb64b8c0cda70ba26" Dec 24 02:47:22 volumio go-librespot[11764]: time="2024-12-24T02:47:22+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:22 volumio go-librespot[11764]: time="2024-12-24T02:47:22+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:22+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:25 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:25 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:25 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Dec 24 02:47:25 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:25 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:25 volumio go-librespot[11819]: Librespot-go daemon starting... Dec 24 02:47:25 volumio go-librespot[11819]: time="2024-12-24T02:47:25+07:00" level=info msg="generated new device id: 20e248f047a96052040048ab17e1865c3ed580ff" Dec 24 02:47:25 volumio go-librespot[11819]: time="2024-12-24T02:47:25+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:26 volumio go-librespot[11819]: time="2024-12-24T02:47:26+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:26+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:28 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:28 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:29 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Dec 24 02:47:29 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:29 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:29 volumio go-librespot[11867]: Librespot-go daemon starting... Dec 24 02:47:29 volumio go-librespot[11867]: time="2024-12-24T02:47:29+07:00" level=info msg="generated new device id: cd0958eb6f1208da0af6e369639a33ce298cba76" Dec 24 02:47:29 volumio go-librespot[11867]: time="2024-12-24T02:47:29+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:29 volumio go-librespot[11867]: time="2024-12-24T02:47:29+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:29+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:31 volumio volumio[5333]: info: Initializing connection to go-librespot Websocket Dec 24 02:47:31 volumio volumio[5333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 24 02:47:32 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 24 02:47:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Dec 24 02:47:32 volumio systemd[1]: Stopped go-librespot Daemon. Dec 24 02:47:32 volumio systemd[1]: Started go-librespot Daemon. Dec 24 02:47:32 volumio go-librespot[11942]: Librespot-go daemon starting... Dec 24 02:47:32 volumio go-librespot[11942]: time="2024-12-24T02:47:32+07:00" level=info msg="generated new device id: 25b5c88461294ba4d55d3f56b27ef328de30d7f0" Dec 24 02:47:32 volumio go-librespot[11942]: time="2024-12-24T02:47:32+07:00" level=debug msg="stored credentials found for 31lvwzvqkq6vwfltmbgsauowme7u" Dec 24 02:47:33 volumio volumio[5333]: info: Starting Uninstall of plugin system_controller - ampswitch Dec 24 02:47:33 volumio volumio[5333]: info: Uninstalling plugin ampswitch Dec 24 02:47:33 volumio volumio[5333]: info: [ASDebug] Port: 24 Dec 24 02:47:33 volumio volumio[5333]: info: [ASDebug] Inverted: false Dec 24 02:47:33 volumio volumio[5333]: info: [ASDebug] Delay: 720 Dec 24 02:47:33 volumio volumio[5333]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 24 02:47:33 volumio volumio[5333]: TypeError: Cannot read property 'unexport' of undefined Dec 24 02:47:33 volumio volumio[5333]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Dec 24 02:47:33 volumio volumio[5333]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Dec 24 02:47:33 volumio volumio[5333]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Dec 24 02:47:33 volumio volumio[5333]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1435:10) Dec 24 02:47:33 volumio volumio[5333]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1424:22) Dec 24 02:47:33 volumio volumio[5333]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1103:45) Dec 24 02:47:33 volumio volumio[5333]: at Socket.emit (events.js:400:28) Dec 24 02:47:33 volumio volumio[5333]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 24 02:47:33 volumio volumio[5333]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Dec 24 02:47:33 volumio volumio[5333]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 24 02:47:33 volumio go-librespot[11942]: time="2024-12-24T02:47:33+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2024-12-24T02:47:33+07:00 is before 2025-01-06T00:00:00Z" Dec 24 02:47:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 24 02:47:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 24 02:47:34 volumio sudo[11995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-24 02:46 Dec 24 02:47:34 volumio sudo[11995]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="613d705c083fd29de3027cf6e63a923a6020da8e" VOLUMIO_FE_VERSION="575f38b17bfc836dbd47f560a440d36ecd98d5af" VOLUMIO_FE3_VERSION="af818e7eb038d49989134ddd7bf2b2ffaa8cf083" VOLUMIO_BE_VERSION="5936439c04ed803864b9ef314729c659b841752e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 29 Jan 2022 12:36:00 AM CET" VOLUMIO_VERSION="3.212" VOLUMIO_HARDWARE="kvim1" VOLUMIO_DEVICENAME="Khadas VIM1" VOLUMIO_HASH="a41712c8cd708e7cae9978278a240084"