-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2024-05-14 19:59:28 CEST. -- May 14 19:58:02 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:02 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:02 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. May 14 19:58:02 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:02 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:02 volumio go-librespot[2937]: Librespot-go daemon starting... May 14 19:58:02 volumio go-librespot[2937]: time="2024-05-14T19:58:02+02:00" level=info msg="generated new device id: ab72d33f18dfe3cfafdf1aad4d2a10c3d1f48fb3" May 14 19:58:02 volumio go-librespot[2937]: time="2024-05-14T19:58:02+02:00" level=debug msg="stored credentials not found" May 14 19:58:02 volumio go-librespot[2937]: time="2024-05-14T19:58:02+02:00" level=debug msg="obtained new client token: AACd1UgaxpIFkXgiC7JobTuOX7B7rIBexYKOxbViwLk5oygCk8RGXexVQt/nS4UL6F34VK0A4Vcbq0oNxEBbDpisRLgdKoSL7bF/KINQ3dfsrK5coAotChvsGjkw5NtFbNgy6ObC6fOLWiEA/q1jbcSPbqXYvKdSzAyz5mh1vEF7UI6w1OsD6W6fc6u6m3ZFUlP2klStQIZdXhrpy/PK67aKYmMdt02sKSxPvahuT6qW/WKUfTda9fCPZTS/dQ==" May 14 19:58:02 volumio go-librespot[2937]: time="2024-05-14T19:58:02+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:02 volumio go-librespot[2937]: time="2024-05-14T19:58:02+02:00" level=debug msg="completed keyexchange" May 14 19:58:03 volumio go-librespot[2937]: time="2024-05-14T19:58:03+02:00" level=debug msg="completed challenge" May 14 19:58:03 volumio go-librespot[2937]: time="2024-05-14T19:58:03+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:04 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:04 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:04 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:04 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:58:04 volumio volumio[946]: info: CoreStateMachine::startPlaybackTimer May 14 19:58:04 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:58:04 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand stop May 14 19:58:04 volumio volumio[946]: info: sendMpdCommand stop took 0 milliseconds May 14 19:58:04 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand clear May 14 19:58:04 volumio volumio[946]: info: May 14 19:58:04 volumio volumio[946]: ---------------------------- MPD announces system playlist update May 14 19:58:04 volumio volumio[946]: info: Ignoring MPD Status Update May 14 19:58:04 volumio volumio[946]: info: sendMpdCommand clear took 1 milliseconds May 14 19:58:04 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand load "NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue" May 14 19:58:04 volumio volumio[946]: error: updateQueue error: null May 14 19:58:04 volumio volumio[946]: info: ------------------------------ 2ms May 14 19:58:05 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:05 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:06 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. May 14 19:58:06 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:06 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:06 volumio go-librespot[2945]: Librespot-go daemon starting... May 14 19:58:06 volumio go-librespot[2945]: time="2024-05-14T19:58:06+02:00" level=info msg="generated new device id: 47d6ab2092a60323cabe7c6c510e15356f0a5a51" May 14 19:58:06 volumio go-librespot[2945]: time="2024-05-14T19:58:06+02:00" level=debug msg="stored credentials not found" May 14 19:58:06 volumio go-librespot[2945]: time="2024-05-14T19:58:06+02:00" level=debug msg="obtained new client token: AACPvk2J15glj6f3O99w4yQ8agdfV18/2NZeRSvaIfd+/M5Z3FZ5nKSQTCQBUyfuPdmyxhMnlQc7mtohZ8UpYmBF8OMAKiy50WfgJ3g/1/dLZFtCNXzgpxEf20vTo8sM/eKaTkzRND60yjyj+a5g7MH8vC5iYZXfYXc5LmOwevkbEshfCzHPQfgLo4bTK7TPhqarSLYIhIStKPRhly/tYJLu/M3wK3Y1L+8+DyqZJX3Kvu46UNspzIxUG7vhow==" May 14 19:58:06 volumio go-librespot[2945]: time="2024-05-14T19:58:06+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:06 volumio go-librespot[2945]: time="2024-05-14T19:58:06+02:00" level=debug msg="completed keyexchange" May 14 19:58:07 volumio go-librespot[2945]: time="2024-05-14T19:58:07+02:00" level=debug msg="completed challenge" May 14 19:58:07 volumio go-librespot[2945]: time="2024-05-14T19:58:07+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:08 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:08 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:09 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 14 19:58:09 volumio volumio[946]: info: CURURI: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue May 14 19:58:09 volumio volumio[946]: info: Preload queue cleared May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:09 volumio volumio[946]: info: Preloading song: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:09 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 in service mpd May 14 19:58:09 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001' May 14 19:58:09 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 in service mpd May 14 19:58:09 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002' May 14 19:58:09 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 in service mpd May 14 19:58:09 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003' May 14 19:58:09 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 in service mpd May 14 19:58:09 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004' May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005' May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006' May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007' May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008' May 14 19:58:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. May 14 19:58:10 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009' May 14 19:58:10 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:10 volumio go-librespot[2992]: Librespot-go daemon starting... May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010' May 14 19:58:10 volumio go-librespot[2992]: time="2024-05-14T19:58:10+02:00" level=info msg="generated new device id: 049b6da318acd6d3478fc4085199ebf882fc5b80" May 14 19:58:10 volumio go-librespot[2992]: time="2024-05-14T19:58:10+02:00" level=debug msg="stored credentials not found" May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011' May 14 19:58:10 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 in service mpd May 14 19:58:10 volumio volumio[946]: error: scanFolder - failure to stat '/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012' May 14 19:58:10 volumio go-librespot[2992]: time="2024-05-14T19:58:10+02:00" level=debug msg="obtained new client token: AADiQnsjdkRMx5scP8ysTmz6waNovlY9AjdVOaqT+zF8cT5i0SviFlMk6dLA+deca6N5BS6XP7XhNrmXAnJFJqHIX7aomvHJa6PRV1jhqA0LApkuk+hncBHIu6y82Jqus++Xdt4Xbi9OhpbrUkpTsM0avJPuqFn56LuEMgsvC8BAOtOo4p2uUUJN1mJdTO9LIz6jZNmgkjI1dKfS2KTdOt8OJFhmLM7W1DhRurIQ7k4UKfoNtTTeW4p2PYVNQg==" May 14 19:58:10 volumio go-librespot[2992]: time="2024-05-14T19:58:10+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:10 volumio go-librespot[2992]: time="2024-05-14T19:58:10+02:00" level=debug msg="completed keyexchange" May 14 19:58:11 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:11 volumio volumio[946]: info: Connection to go-librespot Websocket established May 14 19:58:11 volumio go-librespot[2992]: time="2024-05-14T19:58:11+02:00" level=debug msg="new websocket client" May 14 19:58:11 volumio go-librespot[2992]: time="2024-05-14T19:58:11+02:00" level=debug msg="completed challenge" May 14 19:58:11 volumio go-librespot[2992]: time="2024-05-14T19:58:11+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:11 volumio volumio[946]: info: Connection to go-librespot Websocket closed May 14 19:58:14 volumio volumio[946]: info: Getting Spotify volume May 14 19:58:14 volumio volumio[946]: (node:946) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:14 volumio volumio[946]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) May 14 19:58:14 volumio volumio[946]: (node:946) 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) May 14 19:58:14 volumio volumio[946]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 May 14 19:58:14 volumio volumio[946]: info: CoreCommandRouter::volumioGetState May 14 19:58:14 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:58:14 volumio volumio[946]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 14 19:58:14 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:14 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:14 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. May 14 19:58:14 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:14 volumio volumio[946]: info: Preload queue cleared May 14 19:58:14 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:14 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:14 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:14 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:14 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:14 volumio volumio[946]: info: Preload queue cleared May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:14 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:14 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:14 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:14 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:14 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:14 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::play index 1 May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:14 volumio volumio[946]: info: CorePlayQueue::getTrack 1 May 14 19:58:14 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:14 volumio go-librespot[3001]: Librespot-go daemon starting... May 14 19:58:14 volumio go-librespot[3001]: time="2024-05-14T19:58:14+02:00" level=info msg="generated new device id: a6d2df6eb0cc2870723a8534c27d9b3842fad225" May 14 19:58:14 volumio go-librespot[3001]: time="2024-05-14T19:58:14+02:00" level=debug msg="stored credentials not found" May 14 19:58:14 volumio go-librespot[3001]: time="2024-05-14T19:58:14+02:00" level=debug msg="obtained new client token: AAAKWeknauDWsr+viJpwZLT+yknZo8DURzd8Ofm4W1nJ9hLTKRxzE1lcQtGIBBeKAgJf1BQ7RyeDwthF1pBFCQRiY6fHpCUyMpoyhX1H3tzQjIq9tKnkpnA03DsnEEIfjFGfXfzDtLjyetwbPDBMH9HE/noNd5VbwyFQkwdm/0DktkBXXY6iHbXvSg2UWoWtRHyW1r7KBAEGWH+PW2kVse+U0dtomESnAPrUKRswJoBH1nu0qxscDzIahjIRgA==" May 14 19:58:14 volumio go-librespot[3001]: time="2024-05-14T19:58:14+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:14 volumio go-librespot[3001]: time="2024-05-14T19:58:14+02:00" level=debug msg="completed keyexchange" May 14 19:58:15 volumio volumio[946]: info: Preload queue cleared May 14 19:58:15 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:15 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:15 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:15 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:15 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:15 volumio volumio[946]: info: Preload queue cleared May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:15 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:15 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:15 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:15 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:15 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:15 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::play index 1 May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:15 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:15 volumio volumio[946]: info: CorePlayQueue::getTrack 1 May 14 19:58:15 volumio go-librespot[3001]: time="2024-05-14T19:58:15+02:00" level=debug msg="completed challenge" May 14 19:58:15 volumio go-librespot[3001]: time="2024-05-14T19:58:15+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:16 volumio volumio[946]: info: Preload queue cleared May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:16 volumio volumio[946]: info: Preload queue cleared May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::play index 1 May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::getTrack 1 May 14 19:58:16 volumio volumio[946]: info: Preload queue cleared May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:16 volumio volumio[946]: info: Preload queue cleared May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:16 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:16 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:16 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::play index 1 May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:16 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:16 volumio volumio[946]: info: CorePlayQueue::getTrack 1 May 14 19:58:17 volumio volumio[946]: info: Preload queue cleared May 14 19:58:17 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:17 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:17 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:17 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:17 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:17 volumio volumio[946]: info: Preload queue cleared May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:17 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:17 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:17 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:17 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:17 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:17 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::play index 1 May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:17 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:17 volumio volumio[946]: info: CorePlayQueue::getTrack 1 May 14 19:58:17 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:17 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:18 volumio volumio[946]: info: Preload queue cleared May 14 19:58:18 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:18 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:18 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:18 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:18 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:18 volumio volumio[946]: info: Preload queue cleared May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0001 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0003 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0004 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0005 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0006 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0007 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0008 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0009 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0010 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0011 May 14 19:58:18 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:18 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0012 May 14 19:58:18 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:18 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:18 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:18 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::play index 1 May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:18 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:18 volumio volumio[946]: info: CorePlayQueue::getTrack 1 May 14 19:58:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. May 14 19:58:18 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:18 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:18 volumio go-librespot[3009]: Librespot-go daemon starting... May 14 19:58:18 volumio go-librespot[3009]: time="2024-05-14T19:58:18+02:00" level=info msg="generated new device id: aa0d2ea81d83eb9cba37fdc0febb9b3baf5fb060" May 14 19:58:18 volumio go-librespot[3009]: time="2024-05-14T19:58:18+02:00" level=debug msg="stored credentials not found" May 14 19:58:18 volumio go-librespot[3009]: time="2024-05-14T19:58:18+02:00" level=debug msg="obtained new client token: AADr6M9GyWesN5B7LlrpGCBWvXR3Jgw2NdEwFm3iha+gXQMeynDEusHU05ynoi9X5ypJgDk9UdV8QXfuakVS9JYLNHDEaPcCk1hokNvI17W9taqWYpVT2c7MyOJYJM1sOJlCIoXA0eb/76yuWuVksgk335jv+luIxIZi/5Z0rZdIhZspMMJVX7wfJ/4MkbIk0GZ8s8o2y6+NPXgNiBpZf+/Tot0fR1G17GzqrIJ/ktyDSKCDqxNAzn+HkRP0MA==" May 14 19:58:18 volumio go-librespot[3009]: time="2024-05-14T19:58:18+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:18 volumio go-librespot[3009]: time="2024-05-14T19:58:18+02:00" level=debug msg="completed keyexchange" May 14 19:58:19 volumio go-librespot[3009]: time="2024-05-14T19:58:19+02:00" level=debug msg="completed challenge" May 14 19:58:19 volumio go-librespot[3009]: time="2024-05-14T19:58:19+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:20 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:20 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:21 volumio volumio[946]: info: Adding music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 to favourites using generic method May 14 19:58:21 volumio volumio[946]: info: Saving Cloud item favourites May 14 19:58:21 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: my_volumio , saveCloudItem May 14 19:58:21 volumio volumio[946]: info: Pushing Favourites {"uri":"/mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002","favourite":false} May 14 19:58:22 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. May 14 19:58:22 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:22 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:22 volumio go-librespot[3017]: Librespot-go daemon starting... May 14 19:58:22 volumio go-librespot[3017]: time="2024-05-14T19:58:22+02:00" level=info msg="generated new device id: 5063f3367550de4b0d91e545a675493f21358c3f" May 14 19:58:22 volumio go-librespot[3017]: time="2024-05-14T19:58:22+02:00" level=debug msg="stored credentials not found" May 14 19:58:22 volumio go-librespot[3017]: time="2024-05-14T19:58:22+02:00" level=debug msg="obtained new client token: AABQXOh143AzXw6BOlPzAhQvPViUUOf1haxw7YxS2F9vN8x808pJ8vZ4Wz/iLGivmWV5HfS3C4H6gqySBjcr7HLxn/wy/S7/mG6rqxzKSxdW1/69W3ZtExRuuwEPzhpB6h1NqX84oEVKBRks2ezG/bFabHzW9tmKtY1Ouf5yFSK0XMlyD2+E9i42/6XsczmCMeupiE1WGUBoWwWJlqN4v4pOC62od1kKBHkIjga61T1HOl6AT3jhjbjCsQUFoQ==" May 14 19:58:23 volumio go-librespot[3017]: time="2024-05-14T19:58:23+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:23 volumio go-librespot[3017]: time="2024-05-14T19:58:23+02:00" level=debug msg="completed keyexchange" May 14 19:58:23 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:23 volumio go-librespot[3017]: time="2024-05-14T19:58:23+02:00" level=debug msg="new websocket client" May 14 19:58:23 volumio volumio[946]: info: Connection to go-librespot Websocket established May 14 19:58:23 volumio go-librespot[3017]: time="2024-05-14T19:58:23+02:00" level=debug msg="completed challenge" May 14 19:58:23 volumio go-librespot[3017]: time="2024-05-14T19:58:23+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:23 volumio volumio[946]: info: Connection to go-librespot Websocket closed May 14 19:58:26 volumio volumio[946]: info: Getting Spotify volume May 14 19:58:26 volumio volumio[946]: (node:946) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:26 volumio volumio[946]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) May 14 19:58:26 volumio volumio[946]: (node:946) 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) May 14 19:58:26 volumio volumio[946]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 May 14 19:58:26 volumio volumio[946]: info: CoreCommandRouter::volumioGetState May 14 19:58:26 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:58:26 volumio volumio[946]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 14 19:58:26 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:26 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:26 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. May 14 19:58:26 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:26 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:26 volumio go-librespot[3025]: Librespot-go daemon starting... May 14 19:58:26 volumio go-librespot[3025]: time="2024-05-14T19:58:26+02:00" level=info msg="generated new device id: de8ed3c38b4c19c5464d4953eb99d4862e421b77" May 14 19:58:26 volumio go-librespot[3025]: time="2024-05-14T19:58:26+02:00" level=debug msg="stored credentials not found" May 14 19:58:26 volumio go-librespot[3025]: time="2024-05-14T19:58:26+02:00" level=debug msg="obtained new client token: AACuB8RvSonZBaRL1gpdpkQlOLQFw553ot+5sCq9IuphatTvcdJf3m3l2FBQiqDYcvRbGuckebknu6Z4wabF50VY7PAhwfCPFWzIxgoPN3Iv67NP/uVg6vNPJMGpWcCz2L21d2fshwLit6w7KxNCv2PojkVHQ79EuR5QpqWPsQQIXedkmAW/yER/sUTaiuoIQFv0ncQIaqFAUb+gy2+mDm2zs2Mf7/X1cW0r7r3RTAb8Ua+ueYIz+6z9GYFLNA==" May 14 19:58:27 volumio go-librespot[3025]: time="2024-05-14T19:58:27+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:58:27 volumio go-librespot[3025]: time="2024-05-14T19:58:27+02:00" level=debug msg="completed keyexchange" May 14 19:58:27 volumio volumio[946]: info: Preload queue cleared May 14 19:58:27 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:27 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:27 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:27 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:27 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:27 volumio volumio[946]: info: Preload queue cleared May 14 19:58:27 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:27 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue/track0002 May 14 19:58:27 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:27 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:27 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:27 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::play index 0 May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:27 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:27 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:58:27 volumio go-librespot[3025]: time="2024-05-14T19:58:27+02:00" level=debug msg="completed challenge" May 14 19:58:27 volumio go-librespot[3025]: time="2024-05-14T19:58:27+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:29 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:29 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:30 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. May 14 19:58:30 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:30 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:30 volumio go-librespot[3034]: Librespot-go daemon starting... May 14 19:58:30 volumio go-librespot[3034]: time="2024-05-14T19:58:30+02:00" level=info msg="generated new device id: d8f33bfd2aa8c08073fc5f6800977e3c8567b829" May 14 19:58:30 volumio go-librespot[3034]: time="2024-05-14T19:58:30+02:00" level=debug msg="stored credentials not found" May 14 19:58:30 volumio go-librespot[3034]: time="2024-05-14T19:58:30+02:00" level=debug msg="obtained new client token: AACe42PpNrqoYpx02uRteB9IIq+LM8olGHC6kVxko6jBDeXjadlfgqEfTbw6+8dcsEgRKc3BqmPQ8ZhH2AOW7PhEDDGaxHMJTTnPgouc/UIYtYHbMmwV3U/UcOUg1YZvuRn2X1td5ncrVpB2NfBLKr2vyy/+Jlz9eW2GKRTVqswDyL1vqVLi12RRzUdj/j2n+ZAUkeB6RVgnixTr9eJhYGpiA8DpVegyVEFVmb83wZgrMk84dWknVi5yBJq4yQ==" May 14 19:58:31 volumio go-librespot[3034]: time="2024-05-14T19:58:31+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:58:31 volumio go-librespot[3034]: time="2024-05-14T19:58:31+02:00" level=debug msg="completed keyexchange" May 14 19:58:31 volumio go-librespot[3034]: time="2024-05-14T19:58:31+02:00" level=debug msg="completed challenge" May 14 19:58:31 volumio go-librespot[3034]: time="2024-05-14T19:58:31+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:32 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:32 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:34 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. May 14 19:58:34 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:34 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:34 volumio go-librespot[3042]: Librespot-go daemon starting... May 14 19:58:34 volumio go-librespot[3042]: time="2024-05-14T19:58:34+02:00" level=info msg="generated new device id: b7a3cc815569379ff12717820f45c793b8997041" May 14 19:58:34 volumio go-librespot[3042]: time="2024-05-14T19:58:34+02:00" level=debug msg="stored credentials not found" May 14 19:58:34 volumio go-librespot[3042]: time="2024-05-14T19:58:34+02:00" level=debug msg="obtained new client token: AAAbpm9VjSKcny/3ELPx8ZigoQOMw8jgAWJGykHZztuQ68M/3URQ9K8FbGZUquC/LQ9j7eFBGeItLiVU5JudnDED4N2MmfVoSVlEuY0+acdzf+kmDyLwjvvC+8VbLPhPv7ZraBl05Ag74OwYywWWtYVEhGHvjMqL1gegLI3pC76HcNv0Qn4fL48zPH7/4wSmsTJHiANT+negSWK/eZIvuzg9KWSFxzDFpLU8IVWeYdkhflK3deRkjFZZsND8DA==" May 14 19:58:35 volumio go-librespot[3042]: time="2024-05-14T19:58:35+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:58:35 volumio go-librespot[3042]: time="2024-05-14T19:58:35+02:00" level=debug msg="completed keyexchange" May 14 19:58:35 volumio go-librespot[3042]: time="2024-05-14T19:58:35+02:00" level=debug msg="completed challenge" May 14 19:58:35 volumio go-librespot[3042]: time="2024-05-14T19:58:35+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:35 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:35 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:36 volumio volumio[946]: info: Preload queue cleared May 14 19:58:36 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:36 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:58:36 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:36 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:58:36 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:58:36 volumio volumio[946]: info: Preload queue cleared May 14 19:58:36 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue May 14 19:58:36 volumio volumio[946]: info: Using cached record of: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue May 14 19:58:36 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:58:36 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:58:36 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:58:36 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::play index 0 May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:58:36 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:58:36 volumio volumio[946]: info: CoreStateMachine::startPlaybackTimer May 14 19:58:36 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:58:36 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand stop May 14 19:58:36 volumio volumio[946]: info: sendMpdCommand stop took 3 milliseconds May 14 19:58:36 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand clear May 14 19:58:36 volumio volumio[946]: info: May 14 19:58:36 volumio volumio[946]: ---------------------------- MPD announces system playlist update May 14 19:58:36 volumio volumio[946]: info: Ignoring MPD Status Update May 14 19:58:36 volumio volumio[946]: info: sendMpdCommand clear took 2 milliseconds May 14 19:58:36 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand load "NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Mecano.cue" May 14 19:58:36 volumio volumio[946]: error: updateQueue error: null May 14 19:58:36 volumio volumio[946]: info: ------------------------------ 8ms May 14 19:58:38 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:38 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:38 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. May 14 19:58:38 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:38 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:38 volumio go-librespot[3050]: Librespot-go daemon starting... May 14 19:58:38 volumio go-librespot[3050]: time="2024-05-14T19:58:38+02:00" level=info msg="generated new device id: a94fe440d97466e17f622f9b8e2bcb3a58acc6df" May 14 19:58:38 volumio go-librespot[3050]: time="2024-05-14T19:58:38+02:00" level=debug msg="stored credentials not found" May 14 19:58:38 volumio go-librespot[3050]: time="2024-05-14T19:58:38+02:00" level=debug msg="obtained new client token: AAAxjWvGFlAtGM7fpa8x0rKQAinC140WXRncMgyj3drNUjVM/hteg8TS0kBPqMKkJWB+hp+YIpPkPhRszn+7B4OECC7K9hxXyc5sBhAV0RxEWugPI/5JuZz9KpTqyHwXdFfFHBLN9p270ievCNc9uYsS262CpYg7mjWtHfXiVoLgUYBDVvAeqPdPb+flFXGoqUMkVC8MMXJCHiq7GkD2p4LLWxa4+2dqtIqsmDKSvt7+a3ohPqPXUbtmZ3TLHg==" May 14 19:58:39 volumio go-librespot[3050]: time="2024-05-14T19:58:39+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:58:39 volumio go-librespot[3050]: time="2024-05-14T19:58:39+02:00" level=debug msg="completed keyexchange" May 14 19:58:39 volumio go-librespot[3050]: time="2024-05-14T19:58:39+02:00" level=debug msg="completed challenge" May 14 19:58:39 volumio go-librespot[3050]: time="2024-05-14T19:58:39+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:41 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:41 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:42 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. May 14 19:58:42 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:42 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:42 volumio go-librespot[3058]: Librespot-go daemon starting... May 14 19:58:42 volumio go-librespot[3058]: time="2024-05-14T19:58:42+02:00" level=info msg="generated new device id: 8b6c363c57e719dd0ffcde9ca9f223d4c9bf864a" May 14 19:58:42 volumio go-librespot[3058]: time="2024-05-14T19:58:42+02:00" level=debug msg="stored credentials not found" May 14 19:58:42 volumio go-librespot[3058]: time="2024-05-14T19:58:42+02:00" level=debug msg="obtained new client token: AAChbPX+shTIs45ENTUlt0AAatVfJU8+3Ldeqf67uTxPE+jCAxnXwxV5mEjDIzYdXZTUajjOp+X7tcmeiwHRW7+naTQG7w38tmE/e3x+ZAYSSK3DGOJKZo7K8KrINS1MgoHyaDhakghelus1mj+GVtF/R/mHuNiHwH5nRGrjjvSI5ANGqUvuTquMhpJC6wlMeBQ3aEpzF7ZnCD10n2JdVUm45+00hiSdFl0ac1mTvsYxM9nZiZPYmnPLG0UdiQ==" May 14 19:58:43 volumio go-librespot[3058]: time="2024-05-14T19:58:43+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:43 volumio go-librespot[3058]: time="2024-05-14T19:58:43+02:00" level=debug msg="completed keyexchange" May 14 19:58:43 volumio go-librespot[3058]: time="2024-05-14T19:58:43+02:00" level=debug msg="completed challenge" May 14 19:58:43 volumio go-librespot[3058]: time="2024-05-14T19:58:43+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:44 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:44 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:46 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. May 14 19:58:46 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:46 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:46 volumio go-librespot[3066]: Librespot-go daemon starting... May 14 19:58:46 volumio go-librespot[3066]: time="2024-05-14T19:58:46+02:00" level=info msg="generated new device id: 3e4962c9edc7fd390c9b381411f075afa36e3104" May 14 19:58:46 volumio go-librespot[3066]: time="2024-05-14T19:58:46+02:00" level=debug msg="stored credentials not found" May 14 19:58:46 volumio go-librespot[3066]: time="2024-05-14T19:58:46+02:00" level=debug msg="obtained new client token: AADGJUNbejKAEAB2/oNf7jT36z32Mz0QcR5PX7hFoTK4WszZ7LMv1En2SQxGMsBQ79zaOvL2j8cvBjNd9QOwXlsZNjmJxT6D0sapENDIQhbd6XmaAUKROMDd1cjACbvqw1F6Zk8IH/k6N8F60WBMWy32zYclo+p+/+zHmR1LQ0xpnzvBc0YSTVvuDmpb9XArvuenAM3INbvDF0DoAGfYnmT60Z9fk2Ad3QahiBbT4c/yTz7dFr9ZdMI9b5MZxg==" May 14 19:58:47 volumio go-librespot[3066]: time="2024-05-14T19:58:47+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:58:47 volumio go-librespot[3066]: time="2024-05-14T19:58:47+02:00" level=debug msg="completed keyexchange" May 14 19:58:47 volumio go-librespot[3066]: time="2024-05-14T19:58:47+02:00" level=debug msg="completed challenge" May 14 19:58:47 volumio go-librespot[3066]: time="2024-05-14T19:58:47+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:47 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:47 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:50 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:50 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:50 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. May 14 19:58:50 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:50 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:50 volumio go-librespot[3075]: Librespot-go daemon starting... May 14 19:58:50 volumio go-librespot[3075]: time="2024-05-14T19:58:50+02:00" level=info msg="generated new device id: 9ac21954bcb7d861bc18b91421e486c79d01c596" May 14 19:58:50 volumio go-librespot[3075]: time="2024-05-14T19:58:50+02:00" level=debug msg="stored credentials not found" May 14 19:58:50 volumio go-librespot[3075]: time="2024-05-14T19:58:50+02:00" level=debug msg="obtained new client token: AAClNp+HalqlcJ8BRWWKQVpfnamR4bKj0FIoI7QDwAD+d1wDMzt7uFDSnkAR0aGtcEJz6HgK9bUIyECsu4m5dsJtRVVaYGz4rTzPGOc8TWuRnLurva1j4cgnBvDV0GPftv4QwyOKNRHVMqUjtF5LcgM9adYWTJWzD/2JbXdof5OEu/d3kPfk8jNUhIeLbtA3mAlAETMdS/92rHaCjFgHBEWvjtDn7bkSfEv/LqhbqWiBGlNHGmoga6dFOcEBOQ==" May 14 19:58:51 volumio go-librespot[3075]: time="2024-05-14T19:58:51+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:58:51 volumio go-librespot[3075]: time="2024-05-14T19:58:51+02:00" level=debug msg="completed keyexchange" May 14 19:58:51 volumio go-librespot[3075]: time="2024-05-14T19:58:51+02:00" level=debug msg="completed challenge" May 14 19:58:51 volumio go-librespot[3075]: time="2024-05-14T19:58:51+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:53 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:53 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:54 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. May 14 19:58:54 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:54 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:54 volumio go-librespot[3083]: Librespot-go daemon starting... May 14 19:58:54 volumio go-librespot[3083]: time="2024-05-14T19:58:54+02:00" level=info msg="generated new device id: 86620bc56efe5eb1c8232c59f3f664369e163a07" May 14 19:58:54 volumio go-librespot[3083]: time="2024-05-14T19:58:54+02:00" level=debug msg="stored credentials not found" May 14 19:58:54 volumio go-librespot[3083]: time="2024-05-14T19:58:54+02:00" level=debug msg="obtained new client token: AAAFOcJIkCgP6II2Z21dCW+KOn5BPZuDa8sOfMbGnEdrsy4PI6pDXVMV0+PXl4zzG7LOEOphRRR4NEkSXWqVag4YJpi9hyIQJU3JI61bOguaCmQWZ+cWpEbnAcpVS9nAw8BRdSCaPCnLPN4qiNxtxUaLk3K3aYdxxWQiMv2+pCZDo9O+OWVC06ou6UW3g8YBAZJI2foIHN6vNjtQlMm/2Nh7lHdU43bNF17rVGVVFFY14MfLsJeCOKv1KGWHMw==" May 14 19:58:55 volumio go-librespot[3083]: time="2024-05-14T19:58:55+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:58:55 volumio go-librespot[3083]: time="2024-05-14T19:58:55+02:00" level=debug msg="completed keyexchange" May 14 19:58:55 volumio go-librespot[3083]: time="2024-05-14T19:58:55+02:00" level=debug msg="completed challenge" May 14 19:58:55 volumio go-librespot[3083]: time="2024-05-14T19:58:55+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:56 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:56 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:58:58 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:58:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. May 14 19:58:58 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:58:58 volumio systemd[1]: Started go-librespot Daemon. May 14 19:58:58 volumio go-librespot[3091]: Librespot-go daemon starting... May 14 19:58:58 volumio go-librespot[3091]: time="2024-05-14T19:58:58+02:00" level=info msg="generated new device id: 53de5ac586112a5113c70eaf383baffa3576af95" May 14 19:58:58 volumio go-librespot[3091]: time="2024-05-14T19:58:58+02:00" level=debug msg="stored credentials not found" May 14 19:58:58 volumio go-librespot[3091]: time="2024-05-14T19:58:58+02:00" level=debug msg="obtained new client token: AABbONdLEx8WUyhyawcYjHUUf0t9kysv3UJ/H9cTEPCMV9YVKMr2wSfAHt2Al3TvDLHe7PCeDcDUIYTfkGM2rswXCC4IWQV0XH89lbMlcfIvzVmh/koEljG+aFsxVTghKDZI1f5Y/Skg2qzGGmQdZGsTXYDRxplx1UGeNCkeOZqwhbamsZTd7r8lTj5T7zKpJ161prE8ixZtRSHAeLMTUnzG78jWEB3SpbBcKY/5ibkKtXa3WUSiF+eV3zOVSw==" May 14 19:58:59 volumio go-librespot[3091]: time="2024-05-14T19:58:59+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:58:59 volumio go-librespot[3091]: time="2024-05-14T19:58:59+02:00" level=debug msg="completed keyexchange" May 14 19:58:59 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 14 19:58:59 volumio volumio[946]: info: CURURI: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue May 14 19:58:59 volumio volumio[946]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 14 19:58:59 volumio volumio[946]: info: Preload queue cleared May 14 19:58:59 volumio go-librespot[3091]: time="2024-05-14T19:58:59+02:00" level=debug msg="completed challenge" May 14 19:58:59 volumio go-librespot[3091]: time="2024-05-14T19:58:59+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:58:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:58:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:58:59 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:58:59 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:02 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:02 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:02 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:59:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. May 14 19:59:02 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:59:02 volumio systemd[1]: Started go-librespot Daemon. May 14 19:59:02 volumio go-librespot[3099]: Librespot-go daemon starting... May 14 19:59:02 volumio go-librespot[3099]: time="2024-05-14T19:59:02+02:00" level=info msg="generated new device id: 18b965a02eb7828464c1289cb7279519b72f7b2f" May 14 19:59:02 volumio go-librespot[3099]: time="2024-05-14T19:59:02+02:00" level=debug msg="stored credentials not found" May 14 19:59:02 volumio go-librespot[3099]: time="2024-05-14T19:59:02+02:00" level=debug msg="obtained new client token: AACtytjJVsB0tiJMVJQTfHtpI7NoQm06PIbhyJeZCNQsObBOs3bK/ZeS7+uHy/Q7IBSIb0CNYUHKHCsI0+GF0vLfLszShSkHIQWDJXo4TBQqTmChmaVFpJHE+1VH6XwRaLt4lMevX5W0emDAiExxNkQaCVpCuHcRJavK5YFIZvJi+8q6uXU5Ufi52ge0hrEG/pBaUMgkzN3V6lbIlj/a8DCgrDFxR1G25QGZinvipMKfkfmhd7gTwD3AvGqNZg==" May 14 19:59:03 volumio go-librespot[3099]: time="2024-05-14T19:59:03+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" May 14 19:59:03 volumio go-librespot[3099]: time="2024-05-14T19:59:03+02:00" level=debug msg="completed keyexchange" May 14 19:59:03 volumio go-librespot[3099]: time="2024-05-14T19:59:03+02:00" level=debug msg="completed challenge" May 14 19:59:04 volumio go-librespot[3099]: time="2024-05-14T19:59:04+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:59:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:59:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:59:05 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:05 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:06 volumio volumio[946]: info: Preload queue cleared May 14 19:59:06 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:06 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:59:06 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:59:06 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:59:06 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:59:06 volumio volumio[946]: info: Preload queue cleared May 14 19:59:06 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue May 14 19:59:06 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue in service mpd May 14 19:59:06 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:59:06 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:59:06 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:59:06 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::play index 0 May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:06 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:59:06 volumio volumio[946]: info: CoreStateMachine::startPlaybackTimer May 14 19:59:06 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:59:06 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand stop May 14 19:59:06 volumio volumio[946]: info: sendMpdCommand stop took 5 milliseconds May 14 19:59:06 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand clear May 14 19:59:06 volumio volumio[946]: info: May 14 19:59:06 volumio volumio[946]: ---------------------------- MPD announces system playlist update May 14 19:59:06 volumio volumio[946]: info: Ignoring MPD Status Update May 14 19:59:06 volumio volumio[946]: info: sendMpdCommand clear took 3 milliseconds May 14 19:59:06 volumio volumio[946]: verbose: ControllerMpd::sendMpdCommand load "NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue" May 14 19:59:06 volumio volumio[946]: error: updateQueue error: null May 14 19:59:06 volumio volumio[946]: info: ------------------------------ 3ms May 14 19:59:07 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:59:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. May 14 19:59:07 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:59:07 volumio systemd[1]: Started go-librespot Daemon. May 14 19:59:07 volumio go-librespot[3108]: Librespot-go daemon starting... May 14 19:59:07 volumio go-librespot[3108]: time="2024-05-14T19:59:07+02:00" level=info msg="generated new device id: 5a6f0d784d70c9478a784e744c71161802bc98a4" May 14 19:59:07 volumio go-librespot[3108]: time="2024-05-14T19:59:07+02:00" level=debug msg="stored credentials not found" May 14 19:59:07 volumio go-librespot[3108]: time="2024-05-14T19:59:07+02:00" level=debug msg="obtained new client token: AABCUb7bTfYKAq4PUjR7v7iCXko85i9l8OADrW9NKl/h4eO8/C6IteOtT7eBi03uHPVQuWCIoGAY8q9emUkNyqzKpxzvM+dSVTlQSHUm6tz+m4l6A4LjH4UZb9Wmm940lcNtv4TThDywrFJP4DhHhxbgpqnfBhMHaMlhOMSkvPTJHZiL6GbYx8hOrBaSZtCYucTWMXonC3kGnmuZvtngPWe+ckZeLj9XbBzvV7qFGE8AKCehfo5xrDHw0YEUkQ==" May 14 19:59:07 volumio go-librespot[3108]: time="2024-05-14T19:59:07+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:59:07 volumio go-librespot[3108]: time="2024-05-14T19:59:07+02:00" level=debug msg="completed keyexchange" May 14 19:59:08 volumio go-librespot[3108]: time="2024-05-14T19:59:08+02:00" level=debug msg="completed challenge" May 14 19:59:08 volumio go-librespot[3108]: time="2024-05-14T19:59:08+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:59:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:59:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:59:08 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:08 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:11 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:59:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. May 14 19:59:11 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:59:11 volumio systemd[1]: Started go-librespot Daemon. May 14 19:59:11 volumio go-librespot[3155]: Librespot-go daemon starting... May 14 19:59:11 volumio go-librespot[3155]: time="2024-05-14T19:59:11+02:00" level=info msg="generated new device id: 0b493fbe49a087020f8cf312cc8b429a78258a44" May 14 19:59:11 volumio go-librespot[3155]: time="2024-05-14T19:59:11+02:00" level=debug msg="stored credentials not found" May 14 19:59:11 volumio go-librespot[3155]: time="2024-05-14T19:59:11+02:00" level=debug msg="obtained new client token: AAAr575/vgI+J/ak/6oaUDNlUYMLdWmu+N+VEE2Ax3DzWfxGL6FotMasMzaaoCq+VuSr521WNPYNyf3goYTPQ6AkOeBNiDUwhms2srkcV2MNV8O3VgyEWtgorNpHkXtLDuC5lOyeHlZ1nBcwoldbqEdflWdWWwxn15ptoLKWyj9Neq2btnjIfeT8IwWcM6J1uAk9+L79zTt9E+5t9bL5ISCA/+nCgoYOSbEKUKUNJrSj9396v4nE2rzhvyprXQ==" May 14 19:59:11 volumio go-librespot[3155]: time="2024-05-14T19:59:11+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:59:11 volumio go-librespot[3155]: time="2024-05-14T19:59:11+02:00" level=debug msg="completed keyexchange" May 14 19:59:11 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:11 volumio go-librespot[3155]: time="2024-05-14T19:59:11+02:00" level=debug msg="new websocket client" May 14 19:59:11 volumio volumio[946]: info: Connection to go-librespot Websocket established May 14 19:59:12 volumio go-librespot[3155]: time="2024-05-14T19:59:12+02:00" level=debug msg="completed challenge" May 14 19:59:12 volumio go-librespot[3155]: time="2024-05-14T19:59:12+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:59:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:59:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:59:12 volumio volumio[946]: info: Connection to go-librespot Websocket closed May 14 19:59:14 volumio volumio[946]: info: Preload queue cleared May 14 19:59:14 volumio volumio[946]: info: May 14 19:59:14 volumio volumio[946]: [1715709554376] ---------------------------- Client requests add and Play Volumio CUE entry May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue May 14 19:59:14 volumio volumio[946]: info: Adding CUE individual entry: 1 NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::volumioAddQueueItems May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:59:14 volumio volumio[946]: info: Preload queue cleared May 14 19:59:14 volumio volumio[946]: info: Adding Item to queue: cue://NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue@1 May 14 19:59:14 volumio volumio[946]: info: Exploding uri cue://NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue@1 in service mpd May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::play index 12 May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::getTrack 12 May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:59:14 volumio volumio[946]: info: Getting Spotify volume May 14 19:59:14 volumio volumio[946]: (node:946) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:14 volumio volumio[946]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) May 14 19:59:14 volumio volumio[946]: (node:946) 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: 22) May 14 19:59:14 volumio volumio[946]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::volumioGetState May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:59:14 volumio volumio[946]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 14 19:59:14 volumio volumio[946]: info: Preload queue cleared May 14 19:59:14 volumio volumio[946]: info: May 14 19:59:14 volumio volumio[946]: [1715709554735] ---------------------------- Client requests add and Play Volumio CUE entry May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue May 14 19:59:14 volumio volumio[946]: info: Adding CUE individual entry: 1 NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::volumioAddQueueItems May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:59:14 volumio volumio[946]: info: Preload queue cleared May 14 19:59:14 volumio volumio[946]: info: Adding Item to queue: cue://NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue@1 May 14 19:59:14 volumio volumio[946]: info: Exploding uri cue://NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - ¿Dónde está el país de las hadas.cue@1 in service mpd May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::volumioPlay May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::play index 13 May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::play index undefined May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::getTrack 13 May 14 19:59:14 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:59:14 volumio volumio[946]: info: CoreStateMachine::updateTrackBlock May 14 19:59:14 volumio volumio[946]: info: CorePlayQueue::getTrackBlock May 14 19:59:15 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:15 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:15 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:59:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. May 14 19:59:15 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:59:15 volumio systemd[1]: Started go-librespot Daemon. May 14 19:59:15 volumio go-librespot[3163]: Librespot-go daemon starting... May 14 19:59:15 volumio go-librespot[3163]: time="2024-05-14T19:59:15+02:00" level=info msg="generated new device id: 58ac5465f2d66bf1f23feb26cf73d5040b35603f" May 14 19:59:15 volumio go-librespot[3163]: time="2024-05-14T19:59:15+02:00" level=debug msg="stored credentials not found" May 14 19:59:15 volumio go-librespot[3163]: time="2024-05-14T19:59:15+02:00" level=debug msg="obtained new client token: AACNT80Mi8SO0qrqd9RMl8t8g/C5vs8hnV2+e+Um4SQZEFjjfDnA6Csxmcq7BsBGRXrgW82YuMNu/FZRVtkIcKOtjWo/yYGQSljVhjaQOYCWDlGFRu99uWiTjL82tieOwvjASF1Aa2I9iB8HplI5yAe+fJi95TFYlpepoJNYcPRpP8fhFbEVWTo6cro4MpACp9Ox5g/7j+bBcqeTIkLFHhKXa9mUUzPj0BjFM6LaKaxTFoUJOCVVhtgjGhtvwQ==" May 14 19:59:15 volumio go-librespot[3163]: time="2024-05-14T19:59:15+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:59:15 volumio go-librespot[3163]: time="2024-05-14T19:59:15+02:00" level=debug msg="completed keyexchange" May 14 19:59:16 volumio go-librespot[3163]: time="2024-05-14T19:59:16+02:00" level=debug msg="completed challenge" May 14 19:59:16 volumio go-librespot[3163]: time="2024-05-14T19:59:16+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:59:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:59:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:59:18 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:18 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:19 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:59:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. May 14 19:59:19 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:59:19 volumio systemd[1]: Started go-librespot Daemon. May 14 19:59:19 volumio go-librespot[3172]: Librespot-go daemon starting... May 14 19:59:19 volumio go-librespot[3172]: time="2024-05-14T19:59:19+02:00" level=info msg="generated new device id: f522bdf4d4508ecd8c196128ef44405e769078bf" May 14 19:59:19 volumio go-librespot[3172]: time="2024-05-14T19:59:19+02:00" level=debug msg="stored credentials not found" May 14 19:59:19 volumio go-librespot[3172]: time="2024-05-14T19:59:19+02:00" level=debug msg="obtained new client token: AABuHksrE3Pwyi7U1aaeOeSTue5p4QHqyksZog6mJ1K/DptRoCMEF2VGsOpFD5EA20kv5cEo350TZ6ec8I4MH9aX9ncbOn1LAVAYL0Y4LTwYLHxbQo59ijODNsJxR5DbaJtiCmQhqZm1rNUdMYjSDNR8srnBXpW7PCB0JaxDZXveipuM02Jvahk8scM6lvgF7nREltmuJ4Vs3H1zXmoj0oehhZRAnYr4VQfKjqfcKobm72w4PscFLEotct2l5g==" May 14 19:59:19 volumio go-librespot[3172]: time="2024-05-14T19:59:19+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:59:19 volumio go-librespot[3172]: time="2024-05-14T19:59:19+02:00" level=debug msg="completed keyexchange" May 14 19:59:20 volumio go-librespot[3172]: time="2024-05-14T19:59:20+02:00" level=debug msg="completed challenge" May 14 19:59:20 volumio go-librespot[3172]: time="2024-05-14T19:59:20+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:59:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:59:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:59:21 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:21 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:23 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:59:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. May 14 19:59:23 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:59:23 volumio systemd[1]: Started go-librespot Daemon. May 14 19:59:23 volumio go-librespot[3182]: Librespot-go daemon starting... May 14 19:59:23 volumio go-librespot[3182]: time="2024-05-14T19:59:23+02:00" level=info msg="generated new device id: 2a45745bf396117bebd9baf6c970b894fbd63b42" May 14 19:59:23 volumio go-librespot[3182]: time="2024-05-14T19:59:23+02:00" level=debug msg="stored credentials not found" May 14 19:59:23 volumio go-librespot[3182]: time="2024-05-14T19:59:23+02:00" level=debug msg="obtained new client token: AABtSPX16AhLLl8VsExSuf6Ql6yDYKqDzRcjfwYqI9cXuFQpKLMHsO4DD007ak6gRUv9vgeIvz2regnon4vMxFoYtyVEvnYT1Ms6n0XSfTE66OPfWp2lNVgqlcDQaTLLQOfWT77N/iACQA1tOI9iHJ6OgcJNDMW761QkHxnm9Tz4VcTywPgCQO884eObpxvZY5ZRyYCjAJR9AdXHITXO4n7ng3DkugOupdGk5oOGD4xsDe5JHxrRc+jUU5UgzQ==" May 14 19:59:23 volumio go-librespot[3182]: time="2024-05-14T19:59:23+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:59:23 volumio go-librespot[3182]: time="2024-05-14T19:59:23+02:00" level=debug msg="completed keyexchange" May 14 19:59:24 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:24 volumio go-librespot[3182]: time="2024-05-14T19:59:24+02:00" level=debug msg="new websocket client" May 14 19:59:24 volumio volumio[946]: info: Connection to go-librespot Websocket established May 14 19:59:24 volumio go-librespot[3182]: time="2024-05-14T19:59:24+02:00" level=debug msg="completed challenge" May 14 19:59:24 volumio go-librespot[3182]: time="2024-05-14T19:59:24+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:59:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:59:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:59:24 volumio volumio[946]: info: Connection to go-librespot Websocket closed May 14 19:59:27 volumio volumio[946]: info: Getting Spotify volume May 14 19:59:27 volumio volumio[946]: (node:946) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:27 volumio volumio[946]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) May 14 19:59:27 volumio volumio[946]: (node:946) 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: 23) May 14 19:59:27 volumio volumio[946]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 May 14 19:59:27 volumio volumio[946]: info: CoreCommandRouter::volumioGetState May 14 19:59:27 volumio volumio[946]: info: CorePlayQueue::getTrack 0 May 14 19:59:27 volumio volumio[946]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 14 19:59:27 volumio volumio[946]: info: Initializing connection to go-librespot Websocket May 14 19:59:27 volumio volumio[946]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 14 19:59:27 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 14 19:59:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. May 14 19:59:27 volumio systemd[1]: Stopped go-librespot Daemon. May 14 19:59:27 volumio systemd[1]: Started go-librespot Daemon. May 14 19:59:27 volumio go-librespot[3191]: Librespot-go daemon starting... May 14 19:59:27 volumio go-librespot[3191]: time="2024-05-14T19:59:27+02:00" level=info msg="generated new device id: 8bbab4a2ab992b428e279323b765ca262cb6b902" May 14 19:59:27 volumio go-librespot[3191]: time="2024-05-14T19:59:27+02:00" level=debug msg="stored credentials not found" May 14 19:59:27 volumio go-librespot[3191]: time="2024-05-14T19:59:27+02:00" level=debug msg="obtained new client token: AAAwa1QUR0zYZNFeAz2lPaufZl758NPNzIHDFcZf11+2/FeHSh9dEtZIMGJVPY4Koy5s7jk1fn4zNaewYREvmMLF/Gxq921RZAlSoc5qC2Q3onW+FsWIi4HXGYQck8ikIlHCRHBdnPs4HxznpBk0hQ8rS4boVqBMngrm+ueuNfM1Xq/WpumWV5UqXqAuQKjYRv2ssIYcF4OHFzE1XnprRbT1fLJKnXmBRvTGcMg+jOq709TGpAtPlMNeUIYokA==" May 14 19:59:27 volumio go-librespot[3191]: time="2024-05-14T19:59:27+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" May 14 19:59:27 volumio go-librespot[3191]: time="2024-05-14T19:59:27+02:00" level=debug msg="completed keyexchange" May 14 19:59:28 volumio go-librespot[3191]: time="2024-05-14T19:59:28+02:00" level=debug msg="completed challenge" May 14 19:59:28 volumio go-librespot[3191]: time="2024-05-14T19:59:28+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: failed login: BadCredentials" May 14 19:59:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 14 19:59:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 14 19:59:28 volumio volumio[946]: info: Preload queue cleared May 14 19:59:28 volumio volumio[946]: info: CoreCommandRouter::volumioReplaceandPlayItems May 14 19:59:28 volumio volumio[946]: info: CoreStateMachine::ClearQueue May 14 19:59:28 volumio volumio[946]: info: CoreStateMachine::stop May 14 19:59:28 volumio volumio[946]: info: CoreStateMachine::setConsumeUpdateService undefined May 14 19:59:28 volumio volumio[946]: info: CorePlayQueue::clearPlayQueue May 14 19:59:28 volumio volumio[946]: info: CorePlayQueue::saveQueue May 14 19:59:28 volumio volumio[946]: info: CoreCommandRouter::volumioPushQueue May 14 19:59:28 volumio volumio[946]: info: CoreStateMachine::addQueueItems May 14 19:59:28 volumio volumio[946]: info: CorePlayQueue::addQueueItems May 14 19:59:28 volumio volumio[946]: info: Preload queue cleared May 14 19:59:28 volumio volumio[946]: info: Adding Item to queue: music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE May 14 19:59:28 volumio volumio[946]: info: Exploding uri music-library/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE in service mpd May 14 19:59:28 volumio volumio[946]: info: ALBUMART /albumart?cacheid=902&web=Mecano/Aidalai/extralarge&path=%2Fmnt%2FNAS%2FServidor-Salita%2FCantautores%2FMecano%20-%20Obras%20Completas%20(EAC-FLAC-SCANS)%20BY%20mE%2FMecano%20-%20Aidalai.cue&metadata=false May 14 19:59:28 volumio volumio[946]: info: URI /mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Aidalai.cue May 14 19:59:28 volumio volumio[946]: info: ALBUMART /albumart?cacheid=902&web=Mecano/Aidalai/extralarge&path=%2Fmnt%2FNAS%2FServidor-Salita%2FCantautores%2FMecano%20-%20Obras%20Completas%20(EAC-FLAC-SCANS)%20BY%20mE%2FMecano%20-%20Aidalai.cue&metadata=false May 14 19:59:28 volumio volumio[946]: info: URI /mnt/NAS/Servidor-Salita/Cantautores/Mecano - Obras Completas (EAC-FLAC-SCANS) BY mE/Mecano - Aidalai.cue May 14 19:59:28 volumio volumio[946]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 19:59:28 volumio volumio[946]: Error: Unable to resolve or reject the same promise twice May 14 19:59:28 volumio volumio[946]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 14 19:59:28 volumio volumio[946]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 May 14 19:59:28 volumio volumio[946]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) May 14 19:59:28 volumio volumio[946]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) May 14 19:59:28 volumio volumio[946]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) May 14 19:59:28 volumio volumio[946]: at Socket.emit (events.js:315:20) May 14 19:59:28 volumio volumio[946]: at addChunk (internal/streams/readable.js:309:12) May 14 19:59:28 volumio volumio[946]: at readableAddChunk (internal/streams/readable.js:280:11) May 14 19:59:28 volumio volumio[946]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 14 19:59:28 volumio volumio[946]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 14 19:59:28 volumio volumio[946]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 19:59:28 volumio sudo[3208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-14 19:58 May 14 19:59:28 volumio sudo[3208]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"