-- Logs begin at Fri 2025-06-27 06:41:31 CEST, end at Fri 2025-06-27 13:15:27 CEST. -- Jun 27 13:14:03 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:14:03 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:14:03 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:14:03 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:14:03 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:14:03 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:14:03 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:03 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:14:03 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:14:03 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:03 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:14:03 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:03 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:03 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:14:03 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:03 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:14:03 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:14:03 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:03 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:03 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:14:03 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:14:13 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:14:13 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:14:13 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:14:13 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:14:13 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:14:13 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:14:13 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:13 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:14:13 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:14:13 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:13 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:14:13 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:13 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:13 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:14:13 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:13 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:14:13 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:14:13 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:13 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:23 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:14:23 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:14:23 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:14:23 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:14:23 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:14:23 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:14:23 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:23 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:14:23 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:14:23 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:23 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:14:23 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:23 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:23 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:14:23 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:23 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:14:23 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:14:23 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:23 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:23 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:14:23 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:14:33 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:14:33 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:14:33 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:14:33 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:14:33 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:14:33 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:14:33 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:33 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:14:33 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:14:33 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:33 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:14:33 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:33 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:33 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:14:33 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:33 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:14:33 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:14:33 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:33 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:43 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:14:43 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:14:43 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:14:43 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:14:43 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:14:43 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:14:43 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:43 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:14:43 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:14:43 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:43 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:14:43 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:43 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:43 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:14:43 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:43 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:14:43 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:14:43 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:43 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:43 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:14:43 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:14:50 volumiobureau go-librespot[1176]: time="2025-06-27T13:14:50+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 27 13:14:50 volumiobureau go-librespot[1176]: time="2025-06-27T13:14:50+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 372" Jun 27 13:14:53 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:14:53 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:14:53 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:14:53 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:14:53 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:14:53 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:14:53 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:53 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:14:53 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:14:53 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:53 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:14:53 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:53 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:14:53 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:14:53 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:14:53 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:14:53 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:14:53 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:14:53 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:15:03 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:03+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 27 13:15:03 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:03+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 27 13:15:03 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:15:03 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:15:03 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:15:03 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:15:03 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:15:03 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:15:03 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:03 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:15:03 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:15:03 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:03 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:15:03 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:15:03 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:15:03 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:15:03 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:03 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:15:03 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:15:03 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:15:03 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:15:03 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:15:03 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:15:04 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:04+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 27 13:15:04 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:04+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 27 13:15:04 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:04+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 3194" Jun 27 13:15:04 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:04+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2045" Jun 27 13:15:13 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:15:13 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:15:13 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:15:13 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:15:13 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:15:13 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:15:13 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:13 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:15:13 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:15:13 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:13 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:15:13 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:15:13 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:15:13 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:15:13 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:13 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:15:13 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:15:13 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:15:13 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:15:23 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:15:23 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:15:23 volumiobureau volumio[859]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jun 27 13:15:23 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:15:23 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:15:23 volumiobureau volumio[859]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jun 27 13:15:23 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:23 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jun 27 13:15:23 volumiobureau volumio[859]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jun 27 13:15:23 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:23 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jun 27 13:15:23 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:15:23 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:15:23 volumiobureau volumio[859]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jun 27 13:15:23 volumiobureau volumio[859]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jun 27 13:15:23 volumiobureau volumio[859]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jun 27 13:15:23 volumiobureau volumio[859]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jun 27 13:15:23 volumiobureau volumio[859]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jun 27 13:15:23 volumiobureau volumio[859]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jun 27 13:15:24 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:15:24 volumiobureau volumio[859]: info: Listing playlists Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="handling transfer player command from 2b9fd04e13c72b82cf98c45df7d0b32725351c63" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="resolved context of track" uri="spotify:playlist:1fRVF2TdKMShep9TVvPG4N" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=trace msg="fetched new page 0 with 65 items (list: 65)" uri="spotify:playlist:1fRVF2TdKMShep9TVvPG4N" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="loading track (paused: false, position: 106979ms)" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="renewing login5 access token" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="authenticated as 11163308060" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=trace msg="emitting websocket event: will_play" Jun 27 13:15:25 volumiobureau volumio[859]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4egigjXj8FjX29svOPEa1K","play_origin":"playlist"}} Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="selected format OGG_VORBIS_320 (def687bdbf30a1457f9e02d4c6b9a94e34a4cd91)" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="requested aes key for file def687bdbf30a1457f9e02d4c6b9a94e34a4cd91, gid: 4egigjXj8FjX29svOPEa1K" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2043" Jun 27 13:15:25 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:25+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched first chunk of 17, total size is 8632296 bytes" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched chunk 2/16, size: 524288" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched chunk 1/16, size: 524288" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched chunk 8/16, size: 524288" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=trace msg="seek to 106979ms (diff: 123ms, samples: 4717773, bytes: 4509516)" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched chunk 3/16, size: 524288" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched chunk 9/16, size: 524288" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 10068 us, period size = 444 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 49 frames" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="created new output device" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=info msg="loaded track \"De Kabouterdans - Baba Yega Remix\" (paused: false, position: 106979ms, duration: 209160ms, prefetched: false)" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched chunk 11/16, size: 524288" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="fetched chunk 10/16, size: 524288" uri="spotify:track:4egigjXj8FjX29svOPEa1K" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=trace msg="scheduling prefetch in 72s" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=trace msg="emitting websocket event: metadata" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=trace msg="emitting websocket event: active" Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="sending successful reply for dealer request" Jun 27 13:15:26 volumiobureau volumio[859]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4egigjXj8FjX29svOPEa1K","name":"De Kabouterdans - Baba Yega Remix","artist_names":["Kabouter Plop"],"album_name":"Plop 20 Jaar Hits","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02810f43c05861d09657cdf383","position":106979,"duration":209160,"release_date":"year:2017 month:8 day:25","track_number":21,"disc_number":1}} Jun 27 13:15:26 volumiobureau volumio[859]: SPOTIFY: received: {"type":"active","data":null} Jun 27 13:15:26 volumiobureau volumio[859]: info: Aligning Spotify Volume to Volumio Volume Jun 27 13:15:26 volumiobureau volumio[859]: info: CoreCommandRouter::volumioGetState Jun 27 13:15:26 volumiobureau volumio[859]: info: CorePlayQueue::getTrack 0 Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 27 13:15:26 volumiobureau volumio[859]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 13:15:26 volumiobureau volumio[859]: TypeError: Cannot read property 'name' of undefined Jun 27 13:15:26 volumiobureau volumio[859]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jun 27 13:15:26 volumiobureau volumio[859]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jun 27 13:15:26 volumiobureau volumio[859]: at ControllerSpotify.alignSpotifyVolumeToVolumioVolume (/data/plugins/music_service/spop/index.js:595:36) Jun 27 13:15:26 volumiobureau volumio[859]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:285:18) Jun 27 13:15:26 volumiobureau volumio[859]: at WebSocket.message (/data/plugins/music_service/spop/index.js:190:14) Jun 27 13:15:26 volumiobureau volumio[859]: at WebSocket.emit (events.js:315:20) Jun 27 13:15:26 volumiobureau volumio[859]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Jun 27 13:15:26 volumiobureau volumio[859]: at Receiver.emit (events.js:315:20) Jun 27 13:15:26 volumiobureau volumio[859]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Jun 27 13:15:26 volumiobureau volumio[859]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Jun 27 13:15:26 volumiobureau volumio[859]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Jun 27 13:15:26 volumiobureau volumio[859]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Jun 27 13:15:26 volumiobureau volumio[859]: at writeOrBuffer (internal/streams/writable.js:358:12) Jun 27 13:15:26 volumiobureau volumio[859]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Jun 27 13:15:26 volumiobureau volumio[859]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Jun 27 13:15:26 volumiobureau volumio[859]: at Socket.emit (events.js:315:20) Jun 27 13:15:26 volumiobureau volumio[859]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 13:15:26 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:26+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=trace msg="emitting websocket event: playing" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=trace msg="closed output device because of stop command" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="put connect state inactive" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=trace msg="emitting websocket event: inactive" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2043" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.0.81:34894->104.199.241.202:80: use of closed network connection" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="obtained new client token: AAC/I0Y9yo7kEwxBUKcqefBmFgYGmB01lSbka3QEDVlkCLiWgQ03RHT5Wkoo86/o0dozDZ26eX3Amx89IyOzYOa2hOd1k0mtC0FwGTkQTey+4d6XuMD2izcZ6g85JyXgDW+dZLtjgZtI4tV2dl43ISvXNkeSgi1JrEd8NTRAm3CP3psBAO2S3a+1tLgQ07wh+h12WdsWqfwAmxvQcvpsqHhUy//CDOZ05IlSFWQAthv4SpiyScz1prkizFWO" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=info msg="connected to ap-gew4.spotify.com:4070" Jun 27 13:15:27 volumiobureau go-librespot[1176]: time="2025-06-27T13:15:27+02:00" level=debug msg="completed keyexchange" Jun 27 13:15:27 volumiobureau sudo[8507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 13:14 Jun 27 13:15:27 volumiobureau sudo[8507]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"