-- Logs begin at Sat 2024-05-04 13:35:00 +01, end at Sun 2024-05-05 21:39:12 +01. -- May 05 21:38:04 cuisine volumio[762]: info: May 05 21:38:04 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:04 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:04 cuisine volumio[762]: info: May 05 21:38:04 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:04 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:04 cuisine volumio[762]: info: May 05 21:38:04 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:04 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:04 cuisine volumio[762]: info: sendMpdCommand status took 4 milliseconds May 05 21:38:04 cuisine volumio[762]: info: sendMpdCommand status took 2 milliseconds May 05 21:38:04 cuisine volumio[762]: info: sendMpdCommand status took 2 milliseconds May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:04 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:38:04 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:38:04 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:04 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:04 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:04 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:04 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:04 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:04 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:04 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:04 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:04 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:04 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:04 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:04 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:04 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:04 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:04 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:04 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:04 cuisine volumio[762]: info: ------------------------------ 21ms May 05 21:38:04 cuisine volumio[762]: info: ------------------------------ 19ms May 05 21:38:04 cuisine volumio[762]: info: ------------------------------ 18ms May 05 21:38:07 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:07 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:07 cuisine volumio[762]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 21:38:07 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:38:07 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:38:07 cuisine volumio[762]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 21:38:07 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:07 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 21:38:07 cuisine volumio[762]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 21:38:07 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:07 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 21:38:07 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:07 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:07 cuisine volumio[762]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 21:38:07 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:07 cuisine volumio[762]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 21:38:07 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 21:38:07 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:07 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:07 cuisine volumio[762]: info: Listing playlists May 05 21:38:07 cuisine volumio[762]: info: Listing playlists May 05 21:38:10 cuisine volumio[762]: info: Clearing queue after UPNP request May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::ClearQueue May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::stop May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::stPlaybackTimer May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::updateTrackBlock May 05 21:38:10 cuisine volumio[762]: info: CorePlayQueue::getTrackBlock May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:10 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:10 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 21:38:10 cuisine volumio[762]: info: CoreCommandRouter::volumioPushState May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::serviceStop May 05 21:38:10 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:10 cuisine volumio[762]: info: ControllerMpd::stop May 05 21:38:10 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand stop May 05 21:38:10 cuisine volumio[762]: info: CorePlayQueue::clearPlayQueue May 05 21:38:10 cuisine volumio[762]: info: CorePlayQueue::saveQueue May 05 21:38:10 cuisine volumio[762]: info: CoreCommandRouter::volumioPushState May 05 21:38:10 cuisine volumio[762]: info: CoreCommandRouter::volumioPushQueue May 05 21:38:10 cuisine volumio[762]: info: May 05 21:38:10 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:10 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:10 cuisine volumio[762]: info: sendMpdCommand stop took 6 milliseconds May 05 21:38:10 cuisine volumio[762]: error: updateQueue error: null May 05 21:38:10 cuisine volumio[762]: info: ------------------------------ 14ms May 05 21:38:10 cuisine volumio[762]: info: May 05 21:38:10 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:10 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:10 cuisine volumio[762]: info: May 05 21:38:10 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:10 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:10 cuisine volumio[762]: info: Starting UPNP Playback May 05 21:38:10 cuisine volumio[762]: info: Preparing playback through UPNP May 05 21:38:10 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:10 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:10 cuisine volumio[762]: info: CoreStateMachine::setConsumeUpdateService mpd May 05 21:38:10 cuisine volumio[762]: error: updateQueue error: null May 05 21:38:10 cuisine volumio[762]: error: updateQueue error: null May 05 21:38:10 cuisine volumio[762]: info: ------------------------------ 5ms May 05 21:38:10 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:10 cuisine volumio[762]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 May 05 21:38:10 cuisine volumio[762]: SPOTIFY: SPOTIFY VOLUME 54 May 05 21:38:10 cuisine volumio[762]: SPOTIFY: VOLUMIO VOLUME 64 May 05 21:38:10 cuisine volumio[762]: SPOTIFY: DELTA VOLUME ENOUGH: true May 05 21:38:10 cuisine volumio[762]: info: Setting Spotify Volume from Volumio: 64 May 05 21:38:10 cuisine volumio[762]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 5ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: May 05 21:38:11 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:11 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:11 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:12 cuisine volumio[762]: SPOTIFY: SETTING SPOTIFY VOLUME 64 May 05 21:38:12 cuisine volumio[762]: info: Sending Spotify command with payload to local API: /player/volume May 05 21:38:12 cuisine go-librespot[979]: time="2024-05-05T21:38:12+01:00" level=debug msg="update volume to 41942/65535" May 05 21:38:12 cuisine go-librespot[979]: time="2024-05-05T21:38:12+01:00" level=debug msg="put connect state because VOLUME_CHANGED" May 05 21:38:12 cuisine go-librespot[979]: time="2024-05-05T21:38:12+01:00" level=trace msg="emitting websocket event: volume" May 05 21:38:12 cuisine volumio[762]: SPOTIFY: received: {"type":"volume","data":{"value":64,"max":100}} May 05 21:38:12 cuisine volumio[762]: SPOTIFY: RECEIVED SPOTIFY VOLUME 64 May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 9 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 7 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 6 milliseconds May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:16 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 15 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 11 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 11 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 11 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 6 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 4 milliseconds May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus stop May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 35ms May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 32ms May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 30ms May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:16 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:16 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:16 cuisine volumio[762]: info: May 05 21:38:16 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 17ms May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 16 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 14 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 13 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 14 milliseconds May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 7ms May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 6 milliseconds May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 6ms May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand status took 5 milliseconds May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 45ms May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 35ms May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 33ms May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 12 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 12 milliseconds May 05 21:38:16 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 12 milliseconds May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:16 cuisine volumio[762]: verbose: In UPNP mode May 05 21:38:16 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/043f3c2e9f724ec4a9c50c4fe58726a9.flac?ts=1714941484","trackType":""} May 05 21:38:16 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:38:16 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:38:16 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:38:16 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:16 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 39ms May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 28ms May 05 21:38:16 cuisine volumio[762]: info: ------------------------------ 26ms May 05 21:38:17 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:17 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:17 cuisine volumio[762]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 21:38:17 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:38:17 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:38:17 cuisine volumio[762]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 21:38:17 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:17 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 21:38:17 cuisine volumio[762]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 21:38:17 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:17 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 21:38:17 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:17 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:17 cuisine volumio[762]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 21:38:17 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:17 cuisine volumio[762]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 21:38:17 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 21:38:17 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:17 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:27 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:27 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:27 cuisine volumio[762]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 21:38:27 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:38:27 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:38:27 cuisine volumio[762]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 21:38:27 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:27 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 21:38:27 cuisine volumio[762]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 21:38:27 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:27 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 21:38:27 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:27 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:27 cuisine volumio[762]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 21:38:27 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:27 cuisine volumio[762]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 21:38:27 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 21:38:27 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:27 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:27 cuisine volumio[762]: info: Listing playlists May 05 21:38:27 cuisine volumio[762]: info: Listing playlists May 05 21:38:37 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:37 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:37 cuisine volumio[762]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 21:38:37 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:38:37 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:38:37 cuisine volumio[762]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 21:38:37 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:37 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 21:38:37 cuisine volumio[762]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 21:38:37 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:37 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 21:38:37 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:37 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:37 cuisine volumio[762]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 21:38:37 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:37 cuisine volumio[762]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 21:38:37 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 21:38:37 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:37 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:47 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:47 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:47 cuisine volumio[762]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 21:38:47 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:38:47 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:38:47 cuisine volumio[762]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 21:38:47 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:47 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 21:38:47 cuisine volumio[762]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 21:38:47 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:47 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 21:38:47 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:47 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:47 cuisine volumio[762]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 21:38:47 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:47 cuisine volumio[762]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 21:38:47 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 21:38:47 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:47 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:47 cuisine volumio[762]: info: Listing playlists May 05 21:38:47 cuisine volumio[762]: info: Listing playlists May 05 21:38:52 cuisine volumio[762]: info: May 05 21:38:52 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:52 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:52 cuisine volumio[762]: info: May 05 21:38:52 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:52 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:52 cuisine volumio[762]: info: May 05 21:38:52 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:38:52 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:38:52 cuisine volumio[762]: info: sendMpdCommand status took 4 milliseconds May 05 21:38:52 cuisine volumio[762]: info: sendMpdCommand status took 3 milliseconds May 05 21:38:52 cuisine volumio[762]: info: sendMpdCommand status took 2 milliseconds May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:38:52 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:38:52 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:38:52 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:52 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:38:52 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:52 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:52 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:52 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:52 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:52 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:52 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:52 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:52 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:38:52 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:38:52 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:52 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:52 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:52 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:52 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:38:52 cuisine volumio[762]: info: ------------------------------ 14ms May 05 21:38:52 cuisine volumio[762]: info: ------------------------------ 12ms May 05 21:38:52 cuisine volumio[762]: info: ------------------------------ 11ms May 05 21:38:57 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:57 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:57 cuisine volumio[762]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 21:38:57 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:38:57 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:38:57 cuisine volumio[762]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 21:38:57 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:57 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 21:38:57 cuisine volumio[762]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 21:38:57 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:57 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 21:38:57 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:57 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:57 cuisine volumio[762]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 21:38:57 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:38:57 cuisine volumio[762]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 21:38:57 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 21:38:57 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:38:57 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:38:57 cuisine volumio[762]: info: Clearing queue after UPNP request May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::ClearQueue May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::stop May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::stPlaybackTimer May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::updateTrackBlock May 05 21:38:58 cuisine volumio[762]: info: CorePlayQueue::getTrackBlock May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:38:58 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:58 cuisine volumio[762]: info: CoreCommandRouter::volumioPushState May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::serviceStop May 05 21:38:58 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:58 cuisine volumio[762]: info: ControllerMpd::stop May 05 21:38:58 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand stop May 05 21:38:58 cuisine volumio[762]: info: CorePlayQueue::clearPlayQueue May 05 21:38:58 cuisine volumio[762]: info: CorePlayQueue::saveQueue May 05 21:38:58 cuisine volumio[762]: info: CoreCommandRouter::volumioPushState May 05 21:38:58 cuisine volumio[762]: info: CoreCommandRouter::volumioPushQueue May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: sendMpdCommand stop took 13 milliseconds May 05 21:38:58 cuisine volumio[762]: error: updateQueue error: null May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 7ms May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: error: updateQueue error: null May 05 21:38:58 cuisine volumio[762]: error: updateQueue error: null May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:58 cuisine volumio[762]: info: Starting UPNP Playback May 05 21:38:58 cuisine volumio[762]: info: Preparing playback through UPNP May 05 21:38:58 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:38:58 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:38:58 cuisine volumio[762]: info: CoreStateMachine::setConsumeUpdateService mpd May 05 21:38:58 cuisine volumio[762]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 May 05 21:38:58 cuisine volumio[762]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 5ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 2ms May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: May 05 21:38:58 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:38:58 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 4ms May 05 21:38:58 cuisine volumio[762]: info: ------------------------------ 3ms May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 5 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 4 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 2 milliseconds May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 8 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 7 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 7 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 6 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 5 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 4 milliseconds May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":null,"album":" Home Assistant","uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus stop May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":null,"album":" Home Assistant","uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":null,"album":" Home Assistant","uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 22ms May 05 21:39:03 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 21ms May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 20ms May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 8 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 8 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 8 milliseconds May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":null,"album":" Home Assistant","uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":null,"album":" Home Assistant","uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":null,"album":" Home Assistant","uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:39:03 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:39:03 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 25ms May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 22ms May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 20ms May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:39:03 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:39:03 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces system playlist update May 05 21:39:03 cuisine volumio[762]: info: Ignoring MPD Status Update May 05 21:39:03 cuisine volumio[762]: info: May 05 21:39:03 cuisine volumio[762]: ---------------------------- MPD announces state update: player May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::getState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand status May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 8ms May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 8 milliseconds May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 7ms May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 6 milliseconds May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 6ms May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand status took 5 milliseconds May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseState May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:39:03 cuisine volumio[762]: info: sendMpdCommand playlistinfo took 2 milliseconds May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: verbose: ControllerMpd::parseTrackInfo May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"925 Kbps","isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"925 Kbps","isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: info: ControllerMpd::pushState May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::servicePushState May 05 21:39:03 cuisine volumio[762]: verbose: In UPNP mode May 05 21:39:03 cuisine volumio[762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"925 Kbps","isStreaming":false,"title":"db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","artist":"Music Assistant","album":null,"uri":"http://192.168.1.10:8097/single/media_player.multiroom/db964e5d80ae412a9357a85db4256a13.flac?ts=1714941532","trackType":""} May 05 21:39:03 cuisine volumio[762]: verbose: CURRENT POSITION 0 May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState stateService play May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::syncState currentStatus play May 05 21:39:03 cuisine volumio[762]: info: Received an update from plugin. extracting info from payload May 05 21:39:03 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 21:39:03 cuisine volumio[762]: info: CoreStateMachine::pushState May 05 21:39:03 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:03 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:39:03 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:39:03 cuisine volumio[762]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 22ms May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 20ms May 05 21:39:03 cuisine volumio[762]: info: ------------------------------ 18ms May 05 21:39:07 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:39:07 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:07 cuisine volumio[762]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 21:39:07 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:39:07 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:39:07 cuisine volumio[762]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 21:39:07 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:39:07 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 21:39:07 cuisine volumio[762]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 21:39:07 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:39:07 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 21:39:07 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:39:07 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:39:07 cuisine volumio[762]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 21:39:07 cuisine volumio[762]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 21:39:07 cuisine volumio[762]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 21:39:07 cuisine volumio[762]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 21:39:07 cuisine volumio[762]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 21:39:07 cuisine volumio[762]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 21:39:07 cuisine volumio[762]: info: Listing playlists May 05 21:39:07 cuisine volumio[762]: info: Listing playlists May 05 21:39:11 cuisine sudo[9887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 21:39:11 cuisine sudo[9887]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 21:39:11 cuisine sudo[9887]: pam_unix(sudo:session): session closed for user root May 05 21:39:11 cuisine sudo[9890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 21:39:11 cuisine sudo[9890]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 21:39:11 cuisine sudo[9890]: pam_unix(sudo:session): session closed for user root May 05 21:39:11 cuisine volumio[762]: verbose: New Socket.io Connection to 192.168.1.5 from 192.168.1.223 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 11 May 05 21:39:11 cuisine sudo[9895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 21:39:11 cuisine sudo[9895]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 21:39:11 cuisine sudo[9895]: pam_unix(sudo:session): session closed for user root May 05 21:39:12 cuisine sudo[9898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 21:39:12 cuisine sudo[9898]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 21:39:12 cuisine sudo[9898]: pam_unix(sudo:session): session closed for user root May 05 21:39:12 cuisine volumio[762]: verbose: New Socket.io Connection to 192.168.1.5 from 192.168.1.223 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 12 May 05 21:39:12 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 05 21:39:12 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 05 21:39:12 cuisine volumio[762]: info: CoreCommandRouter::volumioGetVisibleSources May 05 21:39:12 cuisine volumio[762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 21:39:12 cuisine volumio[762]: info: CoreCommandRouter::volumioGetState May 05 21:39:12 cuisine volumio[762]: info: CorePlayQueue::getTrack 0 May 05 21:39:12 cuisine volumio[762]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 21:39:12 cuisine volumio[762]: TypeError: Cannot read property 'name' of undefined May 05 21:39:12 cuisine volumio[762]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 21:39:12 cuisine volumio[762]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) May 05 21:39:12 cuisine volumio[762]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:53:38) May 05 21:39:12 cuisine volumio[762]: at Socket.emit (events.js:315:20) May 05 21:39:12 cuisine volumio[762]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 05 21:39:12 cuisine volumio[762]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 05 21:39:12 cuisine volumio[762]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 21:39:12 cuisine sudo[9910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-05 21:38 May 05 21:39:12 cuisine sudo[9910]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"