-- 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"