-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Fri 2025-07-18 21:38:27 BST. -- Jul 18 21:37:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:00 richdacvolumio go-librespot[1860]: time="2025-07-18T21:37:00+01:00" level=debug msg="completed challenge" Jul 18 21:37:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:02 richdacvolumio volumio[1025]: info: Getting Spotify volume Jul 18 21:37:02 richdacvolumio volumio[1025]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 18 21:37:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:02 richdacvolumio volumio[1025]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 18 21:37:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:03 richdacvolumio go-librespot[1860]: time="2025-07-18T21:37:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Jul 18 21:37:03 richdacvolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jul 18 21:37:03 richdacvolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jul 18 21:37:03 richdacvolumio volumio[1025]: (node:1025) UnhandledPromiseRejectionWarning: Error: socket hang up Jul 18 21:37:03 richdacvolumio volumio[1025]: at connResetException (internal/errors.js:607:14) Jul 18 21:37:03 richdacvolumio volumio[1025]: at Socket.socketOnEnd (_http_client.js:493:23) Jul 18 21:37:03 richdacvolumio volumio[1025]: at Socket.emit (events.js:327:22) Jul 18 21:37:03 richdacvolumio volumio[1025]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 18 21:37:03 richdacvolumio volumio[1025]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 18 21:37:03 richdacvolumio volumio[1025]: (node:1025) 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: 96) Jul 18 21:37:03 richdacvolumio volumio[1025]: info: Connection to go-librespot Websocket closed Jul 18 21:37:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:06 richdacvolumio volumio[1025]: info: Initializing connection to go-librespot Websocket Jul 18 21:37:06 richdacvolumio volumio[1025]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jul 18 21:37:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:07 richdacvolumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jul 18 21:37:07 richdacvolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 283. Jul 18 21:37:07 richdacvolumio systemd[1]: Stopped go-librespot Daemon. Jul 18 21:37:07 richdacvolumio systemd[1]: Started go-librespot Daemon. Jul 18 21:37:07 richdacvolumio go-librespot[2119]: Librespot-go daemon starting... Jul 18 21:37:07 richdacvolumio go-librespot[2119]: time="2025-07-18T21:37:07+01:00" level=info msg="generated new device id: 5cc1a4d94618b244914ea18129fc64f5f522cc91" Jul 18 21:37:07 richdacvolumio go-librespot[2119]: time="2025-07-18T21:37:07+01:00" level=debug msg="stored credentials found for eviesdaddythemainman" Jul 18 21:37:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:07 richdacvolumio go-librespot[2119]: time="2025-07-18T21:37:07+01:00" level=debug msg="obtained new client token: AADVGviR5eFKMWvS79lAioQbNVAtEZRXPLCuk0PqW1rq2nf9RM7CwJwh2v2W209logAkDol2uf1uZik+Ly8ryPaPeyiutgFbnrAFmlLi/TTW2bHo4LNKJP7uUjsIXKYOG/ZBHmBQc1wmoVJFrPBFLMc2mpU5GcR6yS93v+az4g+O2+RC1Zzna0b3FZBkJabKbDtpyuXeCnGwBvUrIWkVC7RRvRm6feWpy540exOtsASBTRMSVmFak+Mb3P0GvA==" Jul 18 21:37:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:08 richdacvolumio go-librespot[2119]: time="2025-07-18T21:37:08+01: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]" Jul 18 21:37:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:08 richdacvolumio go-librespot[2119]: time="2025-07-18T21:37:08+01:00" level=debug msg="completed keyexchange" Jul 18 21:37:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:09 richdacvolumio go-librespot[2119]: time="2025-07-18T21:37:09+01:00" level=debug msg="completed challenge" Jul 18 21:37:09 richdacvolumio go-librespot[2119]: time="2025-07-18T21:37:09+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Jul 18 21:37:09 richdacvolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jul 18 21:37:09 richdacvolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jul 18 21:37:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:09 richdacvolumio volumio[1025]: info: Initializing connection to go-librespot Websocket Jul 18 21:37:09 richdacvolumio volumio[1025]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jul 18 21:37:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:12 richdacvolumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jul 18 21:37:12 richdacvolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 284. Jul 18 21:37:12 richdacvolumio systemd[1]: Stopped go-librespot Daemon. Jul 18 21:37:12 richdacvolumio systemd[1]: Started go-librespot Daemon. Jul 18 21:37:12 richdacvolumio go-librespot[2218]: Librespot-go daemon starting... Jul 18 21:37:12 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:12+01:00" level=info msg="generated new device id: 1c3200a2dedefc016beafb4c197d49b127d60912" Jul 18 21:37:12 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:12+01:00" level=debug msg="stored credentials found for eviesdaddythemainman" Jul 18 21:37:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:12 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:12+01:00" level=debug msg="obtained new client token: AAAChEwLTU/prmh3gh2/KGQe3AyHksxE6F2ggzgL/WoFzrt7zrlA7Unj9vO0UKE0+PtsJ4+az1yJ7fiyQFQa7XfzQGCBlle6ZWTsjO+ravON2FW3Cd3zKRuVmoCuPcFE6JgXkNn4bNFpFZ3xOrPwvL8anYV1c6zIS7712OBb9G6ln0/5lBNb9GVBSlD7fc3QL0xWkSJcqeQmP4M3v+9ymm+th2ymAmbZB98R8FTVj1SO49fsjYXu4cLBFD9nZQ==" Jul 18 21:37:12 richdacvolumio volumio[1025]: info: Initializing connection to go-librespot Websocket Jul 18 21:37:12 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:12+01:00" level=debug msg="new websocket client" Jul 18 21:37:12 richdacvolumio volumio[1025]: info: Connection to go-librespot Websocket established Jul 18 21:37:13 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:13+01: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]" Jul 18 21:37:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:13 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:13+01:00" level=debug msg="completed keyexchange" Jul 18 21:37:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:13 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:13+01:00" level=debug msg="completed challenge" Jul 18 21:37:13 richdacvolumio go-librespot[2218]: time="2025-07-18T21:37:13+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Jul 18 21:37:13 richdacvolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jul 18 21:37:13 richdacvolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jul 18 21:37:13 richdacvolumio volumio[1025]: info: Connection to go-librespot Websocket closed Jul 18 21:37:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: info: Getting Spotify volume Jul 18 21:37:15 richdacvolumio volumio[1025]: (node:1025) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Jul 18 21:37:15 richdacvolumio volumio[1025]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Jul 18 21:37:15 richdacvolumio volumio[1025]: (node:1025) 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: 97) Jul 18 21:37:15 richdacvolumio volumio[1025]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 18 21:37:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:15 richdacvolumio volumio[1025]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 18 21:37:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:16 richdacvolumio volumio[1025]: info: Initializing connection to go-librespot Websocket Jul 18 21:37:16 richdacvolumio volumio[1025]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jul 18 21:37:17 richdacvolumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jul 18 21:37:17 richdacvolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 285. Jul 18 21:37:17 richdacvolumio systemd[1]: Stopped go-librespot Daemon. Jul 18 21:37:17 richdacvolumio systemd[1]: Started go-librespot Daemon. Jul 18 21:37:17 richdacvolumio go-librespot[2325]: Librespot-go daemon starting... Jul 18 21:37:17 richdacvolumio go-librespot[2325]: time="2025-07-18T21:37:17+01:00" level=info msg="generated new device id: 502f57091106940d6bc7242b91634d7d421aa039" Jul 18 21:37:17 richdacvolumio go-librespot[2325]: time="2025-07-18T21:37:17+01:00" level=debug msg="stored credentials found for eviesdaddythemainman" Jul 18 21:37:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:17 richdacvolumio go-librespot[2325]: time="2025-07-18T21:37:17+01:00" level=debug msg="obtained new client token: AACeknclm2h4opgxVPo2CxGCNkqOT7copqg+HuAPb6Up8kjIflbFrZEaZBZC8TOqHl8tF0WL0mEHepGnQbDvNY36+NATluMPWYI88Kx7/ZOlVKOkMbbQ+YEQyTll4l63l3gZ/nlLL/sSeDB20CYxzquzkMH5L9aYNoTTO9WbgHjEPM6fVfrFYjtukmN1ZkId+DU0FJO2wfEl9Kxkc1UM2FyEJDzjjX9joSiCpkyQ4Io76Rek0sWy+32dut2Isg==" Jul 18 21:37:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:18 richdacvolumio go-librespot[2325]: time="2025-07-18T21:37:18+01: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]" Jul 18 21:37:18 richdacvolumio go-librespot[2325]: time="2025-07-18T21:37:18+01:00" level=debug msg="completed keyexchange" Jul 18 21:37:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:18 richdacvolumio go-librespot[2325]: time="2025-07-18T21:37:18+01:00" level=debug msg="completed challenge" Jul 18 21:37:19 richdacvolumio go-librespot[2325]: time="2025-07-18T21:37:19+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Jul 18 21:37:19 richdacvolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jul 18 21:37:19 richdacvolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jul 18 21:37:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:19 richdacvolumio volumio[1025]: info: Initializing connection to go-librespot Websocket Jul 18 21:37:19 richdacvolumio volumio[1025]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jul 18 21:37:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:22 richdacvolumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jul 18 21:37:22 richdacvolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 286. Jul 18 21:37:22 richdacvolumio systemd[1]: Stopped go-librespot Daemon. Jul 18 21:37:22 richdacvolumio systemd[1]: Started go-librespot Daemon. Jul 18 21:37:22 richdacvolumio go-librespot[2425]: Librespot-go daemon starting... Jul 18 21:37:22 richdacvolumio go-librespot[2425]: time="2025-07-18T21:37:22+01:00" level=info msg="generated new device id: 2d5f38010e67f20872ad55e654d6bf5d84beb2d7" Jul 18 21:37:22 richdacvolumio go-librespot[2425]: time="2025-07-18T21:37:22+01:00" level=debug msg="stored credentials found for eviesdaddythemainman" Jul 18 21:37:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:22 richdacvolumio go-librespot[2425]: time="2025-07-18T21:37:22+01:00" level=debug msg="obtained new client token: AAD0bphp6Un2qV/kACrfaW3zY1Wz/XfHw/lUAUyRkUrQ6/SCaZ22fh40ZQ33a/WNvRtaJQDNx4xb2n/YcYrsMBOE1MgePMvNn+/wOx5oyvZsI7Hl9eZ9I5d3z+rvK990lhEF6XOnaFOvABPdUp2dx7yswspnKejnd32twSYkaifWcNnJeVj1jb9tDwLw8bEt/T6k3lw8q5ly6939qS8p+qlOW8wJKE/Pm7CV22yYtfGxZP4xdIDH1mh/EO1pfA==" Jul 18 21:37:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:22 richdacvolumio go-librespot[2425]: time="2025-07-18T21:37:22+01: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]" Jul 18 21:37:22 richdacvolumio volumio[1025]: info: Initializing connection to go-librespot Websocket Jul 18 21:37:22 richdacvolumio go-librespot[2425]: time="2025-07-18T21:37:22+01:00" level=debug msg="new websocket client" Jul 18 21:37:22 richdacvolumio volumio[1025]: info: Connection to go-librespot Websocket established Jul 18 21:37:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:25 richdacvolumio volumio[1025]: info: Getting Spotify volume Jul 18 21:37:25 richdacvolumio volumio[1025]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 18 21:37:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:26 richdacvolumio volumio[1025]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 18 21:37:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:27 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:27 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:27 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:27 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:27 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:27 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:28 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:28 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:28 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:28 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:28 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:28 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:29 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:29 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:29 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:29 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:29 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:29 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:30 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:30 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:30 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:30 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:30 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:30 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:31 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:31 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:31 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:31 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:31 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:31 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:32 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:32 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:32 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:32 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:32 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:32 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:33 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:33 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:33 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:33 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:33 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:33 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:34 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:34 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:34 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:34 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:34 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:34 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:35 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:35 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:35 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:35 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:35 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:36 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:36 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:36 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:36 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:36 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:37 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:37 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:37 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:37 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:37 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:37 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:38 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:38 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:38 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:38 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:38 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:38 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:39 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:39 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:39 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:39 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:39 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:39 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:40 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:40 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:40 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:40 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:40 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:40 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:41 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:41 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:41 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:41 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:41 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:41 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:42 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:42 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:42 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:42 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:42 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:42 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:43 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:43 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:43 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:43 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:43 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:43 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:44 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:44 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:44 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:44 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:44 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:44 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:45 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:45 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:45 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:45 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:45 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:45 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:46 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:46 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:46 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:46 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:46 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:46 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:47 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:47 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:47 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:47 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:47 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:47 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:48 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:48 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:48 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:48 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:48 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:48 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:49 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:49 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:49 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:49 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:49 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:49 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:50 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:50 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:50 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:50 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:50 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:50 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:51 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:51 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:51 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:51 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:51 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:51 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:52 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:52 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:52 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:52 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:52 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:52 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:53 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:53 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:53 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:53 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:53 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:53 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:54 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:54 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:54 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:54 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:54 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:54 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:55 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:55 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:55 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:55 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:55 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:55 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:56 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:56 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:56 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:56 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:56 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:56 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:57 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:57 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:57 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:57 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:57 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:57 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:58 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:58 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:58 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:58 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:58 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:58 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:59 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:59 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:59 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:59 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:59 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:37:59 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:00 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:01 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:02 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:03 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:04 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:05 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:06 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:07 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:08 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:09 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:10 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:11 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:12 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:13 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:14 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:15 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:16 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:17 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:18 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:19 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:20 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:21 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:22 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:23 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:24 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 18 21:38:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:25 richdacvolumio volumio[1025]: info: Preload queue cleared Jul 18 21:38:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:25 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 18 21:38:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:26 richdacvolumio volumio[1025]: info: CoreCommandRouter::volumioGetState Jul 18 21:38:26 richdacvolumio volumio[1025]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 21:38:26 richdacvolumio volumio[1025]: TypeError: Cannot read property 'length' of undefined Jul 18 21:38:26 richdacvolumio volumio[1025]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jul 18 21:38:26 richdacvolumio volumio[1025]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jul 18 21:38:26 richdacvolumio volumio[1025]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jul 18 21:38:26 richdacvolumio volumio[1025]: at Parser.emit (events.js:315:20) Jul 18 21:38:26 richdacvolumio volumio[1025]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jul 18 21:38:26 richdacvolumio volumio[1025]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jul 18 21:38:26 richdacvolumio volumio[1025]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jul 18 21:38:26 richdacvolumio volumio[1025]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jul 18 21:38:26 richdacvolumio volumio[1025]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jul 18 21:38:26 richdacvolumio volumio[1025]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jul 18 21:38:26 richdacvolumio volumio[1025]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jul 18 21:38:26 richdacvolumio volumio[1025]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jul 18 21:38:26 richdacvolumio volumio[1025]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jul 18 21:38:26 richdacvolumio volumio[1025]: at IncomingMessage.emit (events.js:327:22) Jul 18 21:38:26 richdacvolumio volumio[1025]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 18 21:38:26 richdacvolumio volumio[1025]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 18 21:38:26 richdacvolumio volumio[1025]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 21:38:27 richdacvolumio sudo[3761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-18 21:37 Jul 18 21:38:27 richdacvolumio sudo[3761]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"