-- Logs begin at Mon 2025-05-05 10:10:42 ACST, end at Mon 2025-05-05 10:33:57 ACST. -- May 05 10:32:03 volumio volumio[842]: info: May 05 10:32:03 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:03 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:03 volumio volumio[842]: info: May 05 10:32:03 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:03 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:03 volumio volumio[842]: info: May 05 10:32:03 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:03 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:03 volumio volumio[842]: info: sendMpdCommand status took 1 milliseconds May 05 10:32:03 volumio volumio[842]: info: sendMpdCommand status took 2 milliseconds May 05 10:32:03 volumio volumio[842]: info: sendMpdCommand status took 1 milliseconds May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:03 volumio volumio[842]: info: sendMpdCommand playlistinfo took 1 milliseconds May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:03 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:03 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:03 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:03 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:03 volumio volumio[842]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":8220,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"900 Kbps","isStreaming":false,"title":"f6f1086443f042df9cac15096ddaa9f3.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/pBPwAipm/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/f6f1086443f042df9cac15096ddaa9f3.flac","trackType":"flac"} May 05 10:32:03 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::syncState stateService pause May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:03 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:03 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:03 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:03 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:03 volumio volumio[842]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":8220,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"900 Kbps","isStreaming":false,"title":"f6f1086443f042df9cac15096ddaa9f3.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/pBPwAipm/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/f6f1086443f042df9cac15096ddaa9f3.flac","trackType":"flac"} May 05 10:32:03 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::syncState stateService pause May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:03 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:03 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:03 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:03 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:03 volumio volumio[842]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":8220,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"900 Kbps","isStreaming":false,"title":"f6f1086443f042df9cac15096ddaa9f3.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/pBPwAipm/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/f6f1086443f042df9cac15096ddaa9f3.flac","trackType":"flac"} May 05 10:32:03 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::syncState stateService pause May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:03 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:03 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:03 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:03 volumio volumio[842]: info: ------------------------------ 6ms May 05 10:32:04 volumio volumio[842]: info: May 05 10:32:04 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:04 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:04 volumio volumio[842]: info: May 05 10:32:04 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:04 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:04 volumio volumio[842]: info: May 05 10:32:04 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:04 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:04 volumio volumio[842]: info: sendMpdCommand status took 2 milliseconds May 05 10:32:04 volumio volumio[842]: info: sendMpdCommand status took 1 milliseconds May 05 10:32:04 volumio volumio[842]: info: sendMpdCommand status took 0 milliseconds May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:04 volumio volumio[842]: info: sendMpdCommand playlistinfo took 1 milliseconds May 05 10:32:04 volumio volumio[842]: info: sendMpdCommand playlistinfo took 1 milliseconds May 05 10:32:04 volumio volumio[842]: info: sendMpdCommand playlistinfo took 1 milliseconds May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:04 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:04 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:04 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:04 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:04 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9203,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"f6f1086443f042df9cac15096ddaa9f3.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/pBPwAipm/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/f6f1086443f042df9cac15096ddaa9f3.flac","trackType":"flac"} May 05 10:32:04 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:04 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:04 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:04 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:04 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:04 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:04 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:04 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9203,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"f6f1086443f042df9cac15096ddaa9f3.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/pBPwAipm/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/f6f1086443f042df9cac15096ddaa9f3.flac","trackType":"flac"} May 05 10:32:04 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:04 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:04 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:04 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:04 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:04 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:04 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:04 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9203,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"f6f1086443f042df9cac15096ddaa9f3.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/pBPwAipm/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/f6f1086443f042df9cac15096ddaa9f3.flac","trackType":"flac"} May 05 10:32:04 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:04 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:04 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:04 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:04 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:04 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:04 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:04 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:04 volumio volumio[842]: info: ------------------------------ 10ms May 05 10:32:04 volumio volumio[842]: info: ------------------------------ 9ms May 05 10:32:04 volumio volumio[842]: info: ------------------------------ 9ms May 05 10:32:05 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:32:05 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:05 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:32:05 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:32:05 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:32:05 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:32:05 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:05 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:32:05 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:32:05 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:05 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:32:05 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:05 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:05 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:32:05 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:05 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:32:05 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:32:05 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:05 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:15 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:32:15 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:15 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:32:15 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:32:15 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:32:15 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:32:15 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:15 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:32:15 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:32:15 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:15 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:32:15 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:15 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:15 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:32:15 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:15 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:32:15 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:32:15 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:15 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:15 volumio volumio[842]: info: Listing playlists May 05 10:32:15 volumio volumio[842]: info: Listing playlists May 05 10:32:25 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:32:25 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:25 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:32:25 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:32:25 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:32:25 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:32:25 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:25 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:32:25 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:32:25 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:25 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:32:25 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:25 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:25 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:32:25 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:25 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:32:25 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:32:25 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:25 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:35 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:32:35 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:35 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:32:35 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:32:35 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:32:35 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:32:35 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:35 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:32:35 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:32:35 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:35 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:32:35 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:35 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:35 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:32:35 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:35 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:32:35 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:32:35 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:35 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:35 volumio volumio[842]: info: Listing playlists May 05 10:32:45 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:32:45 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:45 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:32:45 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:32:45 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:32:45 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:32:45 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:45 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:32:45 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:32:45 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:45 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:32:45 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:45 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:45 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:32:45 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:45 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:32:45 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:32:45 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:45 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:55 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:32:55 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:55 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:32:55 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:32:55 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:32:55 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:32:55 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:55 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:32:55 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:32:55 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:55 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:32:55 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:55 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:55 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:32:55 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:32:55 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:32:55 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:32:55 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:32:55 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:32:55 volumio volumio[842]: info: Listing playlists May 05 10:32:57 volumio volumio[842]: info: May 05 10:32:57 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:57 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:57 volumio volumio[842]: info: May 05 10:32:57 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:57 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:57 volumio volumio[842]: info: May 05 10:32:57 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:57 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:57 volumio volumio[842]: info: sendMpdCommand status took 2 milliseconds May 05 10:32:57 volumio volumio[842]: info: sendMpdCommand status took 1 milliseconds May 05 10:32:57 volumio volumio[842]: info: sendMpdCommand status took 0 milliseconds May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:57 volumio volumio[842]: info: sendMpdCommand playlistinfo took 1 milliseconds May 05 10:32:57 volumio volumio[842]: info: sendMpdCommand playlistinfo took 1 milliseconds May 05 10:32:57 volumio volumio[842]: info: sendMpdCommand playlistinfo took 1 milliseconds May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:57 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:57 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:57 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:57 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:57 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:57 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:57 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:57 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:57 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:57 volumio volumio[842]: info: ------------------------------ 5ms May 05 10:32:57 volumio volumio[842]: info: ------------------------------ 5ms May 05 10:32:57 volumio volumio[842]: info: ------------------------------ 4ms May 05 10:32:57 volumio volumio[842]: info: Clearing queue after UPNP request May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::ClearQueue May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::stop May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::stPlaybackTimer May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::updateTrackBlock May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::getTrackBlock May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:57 volumio volumio[842]: info: CoreCommandRouter::volumioPushState May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::serviceStop May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:57 volumio volumio[842]: info: ControllerMpd::stop May 05 10:32:57 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand stop May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::clearPlayQueue May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::saveQueue May 05 10:32:57 volumio volumio[842]: info: CoreCommandRouter::volumioPushState May 05 10:32:57 volumio volumio[842]: info: CoreCommandRouter::volumioPushQueue May 05 10:32:57 volumio volumio[842]: info: May 05 10:32:57 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:57 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:57 volumio volumio[842]: info: sendMpdCommand stop took 9 milliseconds May 05 10:32:57 volumio volumio[842]: info: May 05 10:32:57 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:57 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:57 volumio volumio[842]: info: May 05 10:32:57 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:57 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:57 volumio volumio[842]: error: updateQueue error: null May 05 10:32:57 volumio volumio[842]: error: updateQueue error: null May 05 10:32:57 volumio volumio[842]: error: updateQueue error: null May 05 10:32:57 volumio volumio[842]: info: ------------------------------ 5ms May 05 10:32:57 volumio volumio[842]: info: ------------------------------ 3ms May 05 10:32:57 volumio volumio[842]: info: ------------------------------ 2ms May 05 10:32:57 volumio volumio[842]: info: Starting UPNP Playback May 05 10:32:57 volumio volumio[842]: info: Preparing playback through UPNP May 05 10:32:57 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:32:57 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:57 volumio volumio[842]: info: CoreStateMachine::setConsumeUpdateService mpd May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 1ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 0ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 1ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 1ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 1ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 0ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 1ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 1ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 1ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 0ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand status took 5 milliseconds May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand status took 3 milliseconds May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand status took 8 milliseconds May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 10ms May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand playlistinfo took 8 milliseconds May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand playlistinfo took 7 milliseconds May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand status took 4 milliseconds May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus stop May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 30ms May 05 10:32:58 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:58 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 29ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 29ms May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces system playlist update May 05 10:32:58 volumio volumio[842]: info: Ignoring MPD Status Update May 05 10:32:58 volumio volumio[842]: info: May 05 10:32:58 volumio volumio[842]: ---------------------------- MPD announces state update: player May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::getState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand status May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand status took 21 milliseconds May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand playlistinfo took 19 milliseconds May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand playlistinfo took 18 milliseconds May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":292,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"449 Kbps","isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"454 Kbps","isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"454 Kbps","isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 33ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 29ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 27ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 13ms May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand status took 13 milliseconds May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 12ms May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand status took 11 milliseconds May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand playlistinfo took 11 milliseconds May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseState May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"460 Kbps","isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 40ms May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand playlistinfo took 6 milliseconds May 05 10:32:58 volumio volumio[842]: info: sendMpdCommand playlistinfo took 6 milliseconds May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:58 volumio volumio[842]: verbose: ControllerMpd::parseTrackInfo May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"460 Kbps","isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: info: ControllerMpd::pushState May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::servicePushState May 05 10:32:58 volumio volumio[842]: verbose: In UPNP mode May 05 10:32:58 volumio volumio[842]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"460 Kbps","isStreaming":false,"title":"48f17a71d17546938a42afe62a1ee453.flac","artist":"Music Assistant","album":null,"uri":"http://192.168.1.101:8097/flow/jTvgBA2m/uuid:548a2cb5-2925-37ea-1818-52540019f9b7/48f17a71d17546938a42afe62a1ee453.flac","trackType":"flac"} May 05 10:32:58 volumio volumio[842]: verbose: CURRENT POSITION 1 May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState stateService play May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::syncState currentStatus play May 05 10:32:58 volumio volumio[842]: info: Received an update from plugin. extracting info from payload May 05 10:32:58 volumio volumio[842]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 05 10:32:58 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:32:58 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:32:58 volumio volumio[842]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 24ms May 05 10:32:58 volumio volumio[842]: info: ------------------------------ 22ms May 05 10:33:05 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:33:05 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:05 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:33:05 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:33:05 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:33:05 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:33:05 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:05 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:33:05 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:33:05 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:05 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:33:05 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:05 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:05 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:33:05 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:05 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:33:05 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:33:05 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:05 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:07 volumio volumio[1676]: 100 May 05 10:33:07 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:07 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:07 volumio volumio[842]: info: May 05 10:33:07 volumio volumio[842]: ---------------------------- Client requests Volume 100 May 05 10:33:07 volumio volumio[842]: info: VolumeController::SetAlsaVolume100 May 05 10:33:07 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:07 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:07 volumio volumio[1676]: [158B blob data] May 05 10:33:07 volumio volumio[1676]: {"time":1746406987966,"response":"volume Success"}100 May 05 10:33:09 volumio volumio[1676]: 56 May 05 10:33:09 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:09 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:09 volumio volumio[842]: info: May 05 10:33:09 volumio volumio[842]: ---------------------------- Client requests Volume 56 May 05 10:33:09 volumio volumio[842]: info: VolumeController::SetAlsaVolume56 May 05 10:33:09 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:09 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:09 volumio volumio[1676]: [158B blob data] May 05 10:33:09 volumio volumio[1676]: {"time":1746406989781,"response":"volume Success"}56 May 05 10:33:11 volumio volumio[1676]: 54 May 05 10:33:11 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:11 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:11 volumio volumio[842]: info: May 05 10:33:11 volumio volumio[842]: ---------------------------- Client requests Volume 54 May 05 10:33:11 volumio volumio[842]: info: VolumeController::SetAlsaVolume54 May 05 10:33:11 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:11 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:11 volumio volumio[1676]: [158B blob data] May 05 10:33:11 volumio volumio[1676]: {"time":1746406991120,"response":"volume Success"}54 May 05 10:33:12 volumio volumio[1676]: 46 May 05 10:33:12 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:12 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:12 volumio volumio[842]: info: May 05 10:33:12 volumio volumio[842]: ---------------------------- Client requests Volume 46 May 05 10:33:12 volumio volumio[842]: info: VolumeController::SetAlsaVolume46 May 05 10:33:12 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:12 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:12 volumio volumio[1676]: [158B blob data] May 05 10:33:12 volumio volumio[1676]: {"time":1746406992309,"response":"volume Success"}46 May 05 10:33:13 volumio volumio[1676]: 52 May 05 10:33:13 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:13 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:13 volumio volumio[842]: info: May 05 10:33:13 volumio volumio[842]: ---------------------------- Client requests Volume 52 May 05 10:33:13 volumio volumio[842]: info: VolumeController::SetAlsaVolume52 May 05 10:33:13 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:13 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:13 volumio volumio[1676]: [158B blob data] May 05 10:33:13 volumio volumio[1676]: {"time":1746406993219,"response":"volume Success"}52 May 05 10:33:15 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:33:15 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:15 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:33:15 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:33:15 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:33:15 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:33:15 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:15 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:33:15 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:33:15 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:15 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:33:15 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:15 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:15 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:33:15 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:15 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:33:15 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:33:15 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:15 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:15 volumio volumio[842]: info: Listing playlists May 05 10:33:15 volumio volumio[842]: info: Listing playlists May 05 10:33:25 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:33:25 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:25 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:33:25 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:33:25 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:33:25 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:33:25 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:25 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:33:25 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:33:25 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:25 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:33:25 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:25 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:25 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:33:25 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:25 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:33:25 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:33:25 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:25 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:28 volumio volumio[1676]: 71 May 05 10:33:28 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:28 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:28 volumio volumio[842]: info: May 05 10:33:28 volumio volumio[842]: ---------------------------- Client requests Volume 71 May 05 10:33:28 volumio volumio[842]: info: VolumeController::SetAlsaVolume71 May 05 10:33:28 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:28 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:28 volumio volumio[1676]: [158B blob data] May 05 10:33:28 volumio volumio[1676]: {"time":1746407008378,"response":"volume Success"}71 May 05 10:33:29 volumio volumio[1676]: 87 May 05 10:33:29 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:29 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:29 volumio volumio[842]: info: May 05 10:33:29 volumio volumio[842]: ---------------------------- Client requests Volume 87 May 05 10:33:29 volumio volumio[842]: info: VolumeController::SetAlsaVolume87 May 05 10:33:29 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:29 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:29 volumio volumio[1676]: [158B blob data] May 05 10:33:29 volumio volumio[1676]: {"time":1746407009290,"response":"volume Success"}87 May 05 10:33:34 volumio volumio[1676]: 100 May 05 10:33:34 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:34 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:34 volumio volumio[842]: info: May 05 10:33:34 volumio volumio[842]: ---------------------------- Client requests Volume 100 May 05 10:33:34 volumio volumio[842]: info: VolumeController::SetAlsaVolume100 May 05 10:33:34 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:34 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:34 volumio volumio[1676]: [158B blob data] May 05 10:33:34 volumio volumio[1676]: {"time":1746407014899,"response":"volume Success"}100 May 05 10:33:35 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:33:35 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:35 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:33:35 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:33:35 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:33:35 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:33:35 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:35 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:33:35 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:33:35 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:35 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:33:35 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:35 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:35 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:33:35 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:35 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:33:35 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:33:35 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:35 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:35 volumio volumio[842]: info: Listing playlists May 05 10:33:35 volumio volumio[842]: info: Listing playlists May 05 10:33:40 volumio volumio[1676]: 52 May 05 10:33:40 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:40 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:40 volumio volumio[842]: info: May 05 10:33:40 volumio volumio[842]: ---------------------------- Client requests Volume 52 May 05 10:33:40 volumio volumio[842]: info: VolumeController::SetAlsaVolume52 May 05 10:33:40 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:40 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:40 volumio volumio[1676]: [158B blob data] May 05 10:33:40 volumio volumio[1676]: {"time":1746407020026,"response":"volume Success"}52 May 05 10:33:41 volumio volumio[1676]: 76 May 05 10:33:41 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:41 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:41 volumio volumio[842]: info: May 05 10:33:41 volumio volumio[842]: ---------------------------- Client requests Volume 76 May 05 10:33:41 volumio volumio[842]: info: VolumeController::SetAlsaVolume76 May 05 10:33:41 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:41 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:41 volumio volumio[1676]: [158B blob data] May 05 10:33:41 volumio volumio[1676]: {"time":1746407021032,"response":"volume Success"}76 May 05 10:33:41 volumio volumio[1676]: 100 May 05 10:33:41 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:41 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:41 volumio volumio[842]: info: May 05 10:33:41 volumio volumio[842]: ---------------------------- Client requests Volume 100 May 05 10:33:41 volumio volumio[842]: info: VolumeController::SetAlsaVolume100 May 05 10:33:41 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:41 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:41 volumio volumio[1676]: [158B blob data] May 05 10:33:41 volumio volumio[1676]: {"time":1746407021783,"response":"volume Success"}100 May 05 10:33:45 volumio volumio[1676]: 99 May 05 10:33:45 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:45 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:45 volumio volumio[842]: info: May 05 10:33:45 volumio volumio[842]: ---------------------------- Client requests Volume 99 May 05 10:33:45 volumio volumio[842]: info: VolumeController::SetAlsaVolume99 May 05 10:33:45 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:45 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:45 volumio volumio[1676]: [158B blob data] May 05 10:33:45 volumio volumio[1676]: {"time":1746407025188,"response":"volume Success"}99 May 05 10:33:45 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:33:45 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:45 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:33:45 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:33:45 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:33:45 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:33:45 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:45 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:33:45 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:33:45 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:45 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:33:45 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:45 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:45 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:33:45 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:45 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:33:45 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:33:45 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:45 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:45 volumio volumio[1676]: 96 May 05 10:33:45 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:45 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:45 volumio volumio[842]: info: May 05 10:33:45 volumio volumio[842]: ---------------------------- Client requests Volume 96 May 05 10:33:45 volumio volumio[842]: info: VolumeController::SetAlsaVolume96 May 05 10:33:45 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:45 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:45 volumio volumio[1676]: [158B blob data] May 05 10:33:45 volumio volumio[1676]: {"time":1746407025880,"response":"volume Success"}96 May 05 10:33:46 volumio volumio[1676]: 100 May 05 10:33:46 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:46 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:46 volumio volumio[842]: info: May 05 10:33:46 volumio volumio[842]: ---------------------------- Client requests Volume 100 May 05 10:33:46 volumio volumio[842]: info: VolumeController::SetAlsaVolume100 May 05 10:33:46 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:46 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:46 volumio volumio[1676]: [158B blob data] May 05 10:33:46 volumio volumio[1676]: {"time":1746407026412,"response":"volume Success"}100 May 05 10:33:50 volumio volumio[1676]: 28 May 05 10:33:50 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:50 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:50 volumio volumio[842]: info: May 05 10:33:50 volumio volumio[842]: ---------------------------- Client requests Volume 28 May 05 10:33:50 volumio volumio[842]: info: VolumeController::SetAlsaVolume28 May 05 10:33:50 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:50 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:50 volumio volumio[1676]: [158B blob data] May 05 10:33:50 volumio volumio[1676]: {"time":1746407030183,"response":"volume Success"}28 May 05 10:33:50 volumio volumio[1676]: 4 May 05 10:33:50 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:50 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:51 volumio volumio[842]: info: May 05 10:33:51 volumio volumio[842]: ---------------------------- Client requests Volume 4 May 05 10:33:51 volumio volumio[842]: info: VolumeController::SetAlsaVolume4 May 05 10:33:51 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:51 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:51 volumio volumio[1676]: [158B blob data] May 05 10:33:51 volumio volumio[1676]: {"time":1746407031004,"response":"volume Success"}4 May 05 10:33:51 volumio volumio[1676]: 100 May 05 10:33:51 volumio volumio[1676]: % Total % Received % Xferd Average Speed Time Time Time Current May 05 10:33:51 volumio volumio[1676]: Dload Upload Total Spent Left Speed May 05 10:33:51 volumio volumio[842]: info: May 05 10:33:51 volumio volumio[842]: ---------------------------- Client requests Volume 100 May 05 10:33:51 volumio volumio[842]: info: VolumeController::SetAlsaVolume100 May 05 10:33:51 volumio volumio[842]: info: CoreStateMachine::pushState May 05 10:33:51 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:51 volumio volumio[1676]: [158B blob data] May 05 10:33:51 volumio volumio[1676]: {"time":1746407031587,"response":"volume Success"}100 May 05 10:33:55 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:33:55 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:55 volumio volumio[842]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined May 05 10:33:55 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:33:55 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:33:55 volumio volumio[842]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) May 05 10:33:55 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:55 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 05 10:33:55 volumio volumio[842]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 05 10:33:55 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:55 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 05 10:33:55 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:55 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:55 volumio volumio[842]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) May 05 10:33:55 volumio volumio[842]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 05 10:33:55 volumio volumio[842]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) May 05 10:33:55 volumio volumio[842]: at /volumio/node_modules/express/lib/router/index.js:284:7 May 05 10:33:55 volumio volumio[842]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 05 10:33:55 volumio volumio[842]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 05 10:33:55 volumio volumio[842]: info: Listing playlists May 05 10:33:55 volumio volumio[842]: info: Listing playlists May 05 10:33:57 volumio volumio[842]: info: CoreCommandRouter::volumioGetState May 05 10:33:57 volumio volumio[842]: info: CorePlayQueue::getTrack 1 May 05 10:33:57 volumio volumio[842]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 10:33:57 volumio volumio[842]: TypeError: Cannot read property 'name' of undefined May 05 10:33:57 volumio volumio[842]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) May 05 10:33:57 volumio volumio[842]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) May 05 10:33:57 volumio volumio[842]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:58:38) May 05 10:33:57 volumio volumio[842]: at Socket.emit (events.js:400:28) May 05 10:33:57 volumio volumio[842]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 05 10:33:57 volumio volumio[842]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 05 10:33:57 volumio volumio[842]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 10:33:57 volumio sudo[5927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-05 10:32 May 05 10:33:57 volumio sudo[5927]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"