-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-07-21 09:50:47 CEST. --
Jul 21 09:49:05 volumio volumio[836]: info:
Jul 21 09:49:05 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:05 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:05 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:05 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:49:05 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:05 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:05 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:05 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:05 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:05 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:05 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:05 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:05 volumio volumio[836]: info: ------------------------------ 5ms
Jul 21 09:49:05 volumio volumio[836]: info: Clearing queue after UPNP request
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::ClearQueue
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::stop
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock
Jul 21 09:49:05 volumio volumio[836]: info: CorePlayQueue::getTrackBlock
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:05 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:05 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::serviceStop
Jul 21 09:49:05 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:05 volumio volumio[836]: info: ControllerMpd::stop
Jul 21 09:49:05 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 09:49:05 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue
Jul 21 09:49:05 volumio volumio[836]: info: CorePlayQueue::saveQueue
Jul 21 09:49:05 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:05 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue
Jul 21 09:49:05 volumio volumio[836]: info:
Jul 21 09:49:05 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:05 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:05 volumio volumio[836]: info: sendMpdCommand stop took 16 milliseconds
Jul 21 09:49:05 volumio volumio[836]: error: updateQueue error: null
Jul 21 09:49:05 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:05 volumio volumio[836]: info: Starting UPNP Playback
Jul 21 09:49:05 volumio volumio[836]: info: Preparing playback through UPNP
Jul 21 09:49:05 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:05 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:05 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 21 09:49:06 volumio volumio[836]: info:
Jul 21 09:49:06 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:06 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:06 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:06 volumio volumio[836]: info:
Jul 21 09:49:06 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:06 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:06 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:06 volumio volumio[836]: info:
Jul 21 09:49:06 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:06 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:06 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:06 volumio volumio[836]: info:
Jul 21 09:49:06 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:06 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:06 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:06 volumio volumio[836]: info:
Jul 21 09:49:06 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:06 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:06 volumio volumio[836]: info: ------------------------------ 0ms
Jul 21 09:49:06 volumio volumio[836]: info:
Jul 21 09:49:06 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:06 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:06 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:06 volumio volumio[836]: info: Clearing queue after UPNP request
Jul 21 09:49:06 volumio volumio[836]: info: CoreStateMachine::ClearQueue
Jul 21 09:49:06 volumio volumio[836]: info: CoreStateMachine::stop
Jul 21 09:49:06 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 09:49:06 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue
Jul 21 09:49:06 volumio volumio[836]: info: CorePlayQueue::saveQueue
Jul 21 09:49:06 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:06 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue
Jul 21 09:49:06 volumio volumio[836]: info:
Jul 21 09:49:06 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:06 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:06 volumio volumio[836]: error: updateQueue error: null
Jul 21 09:49:06 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:06 volumio volumio[836]: info: Starting UPNP Playback
Jul 21 09:49:06 volumio volumio[836]: info: Preparing playback through UPNP
Jul 21 09:49:06 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:06 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:06 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:07 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:07 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:07 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 0ms
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:07 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:07 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:07 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:07 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:07 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:07 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:49:07 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:49:07 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:49:07 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:07 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:49:07 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:49:07 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:07 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:49:07 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:07 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:07 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:49:07 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:07 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:49:07 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:49:07 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:07 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:07 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:07 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:07 volumio volumio[836]: info: sendMpdCommand status took 16 milliseconds
Jul 21 09:49:07 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:07 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:49:07 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:07 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:07 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:07 volumio volumio[836]: 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":"Riverside","artist":"Agnes Obel","album":"Philharmonics","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/03a5393ce46846799edcc7f6b2950994.flac?ts=1721548146","trackType":""}
Jul 21 09:49:07 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 21ms
Jul 21 09:49:07 volumio volumio[836]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:07 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:07 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:07 volumio volumio[836]: 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":"Riverside","artist":"Agnes Obel","album":"Philharmonics","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/03a5393ce46846799edcc7f6b2950994.flac?ts=1721548146","trackType":""}
Jul 21 09:49:07 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:07 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 28ms
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:07 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:07 volumio volumio[836]: info:
Jul 21 09:49:07 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:07 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 8ms
Jul 21 09:49:07 volumio volumio[836]: info: sendMpdCommand status took 7 milliseconds
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:07 volumio volumio[836]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 21 09:49:07 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:07 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:07 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:07 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"525 Kbps","isStreaming":false,"title":"03a5393ce46846799edcc7f6b2950994.flac?ts=1721548146","artist":"Music Assistant","album":null,"uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/03a5393ce46846799edcc7f6b2950994.flac?ts=1721548146","trackType":""}
Jul 21 09:49:07 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:07 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:07 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:07 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:07 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:07 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:07 volumio volumio[836]: info: ------------------------------ 11ms
Jul 21 09:49:17 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:17 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:17 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:17 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:49:17 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:49:17 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:49:17 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:17 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:49:17 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:49:17 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:17 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:49:17 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:17 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:17 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:49:17 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:17 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:49:17 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:49:17 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:17 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:17 volumio volumio[836]: info: Listing playlists
Jul 21 09:49:17 volumio volumio[836]: info: Listing playlists
Jul 21 09:49:21 volumio volumio[836]: info:
Jul 21 09:49:21 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:21 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:21 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:21 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:49:21 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:21 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:21 volumio volumio[836]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 21 09:49:21 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:21 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:21 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:21 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:21 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:21 volumio volumio[836]: info: ------------------------------ 10ms
Jul 21 09:49:21 volumio volumio[836]: info: Clearing queue after UPNP request
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::ClearQueue
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::stop
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock
Jul 21 09:49:21 volumio volumio[836]: info: CorePlayQueue::getTrackBlock
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:21 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:21 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:49:21 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::serviceStop
Jul 21 09:49:21 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:21 volumio volumio[836]: info: ControllerMpd::stop
Jul 21 09:49:21 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 09:49:21 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue
Jul 21 09:49:21 volumio volumio[836]: info: CorePlayQueue::saveQueue
Jul 21 09:49:21 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:21 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue
Jul 21 09:49:21 volumio volumio[836]: info:
Jul 21 09:49:21 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:21 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:21 volumio volumio[836]: info: sendMpdCommand stop took 19 milliseconds
Jul 21 09:49:21 volumio volumio[836]: error: updateQueue error: null
Jul 21 09:49:21 volumio volumio[836]: info: ------------------------------ 2ms
Jul 21 09:49:21 volumio volumio[836]: info: Starting UPNP Playback
Jul 21 09:49:21 volumio volumio[836]: info: Preparing playback through UPNP
Jul 21 09:49:21 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:21 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:21 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:22 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 2ms
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:22 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:22 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:22 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:22 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:22 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:22 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 21 09:49:22 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:22 volumio volumio[836]: info: sendMpdCommand status took 15 milliseconds
Jul 21 09:49:22 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:22 volumio volumio[836]: info: sendMpdCommand status took 2 milliseconds
Jul 21 09:49:22 volumio volumio[836]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:22 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:22 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:22 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:22 volumio volumio[836]: 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":"On Powdered Ground","artist":"Agnes Obel","album":"Philharmonics","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/cf9413e22d20473fa50ca1b7c3c4216f.flac?ts=1721548161","trackType":""}
Jul 21 09:49:22 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 21ms
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:22 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:22 volumio volumio[836]: info:
Jul 21 09:49:22 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:22 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:22 volumio volumio[836]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:22 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:22 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:22 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:22 volumio volumio[836]: 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":"cf9413e22d20473fa50ca1b7c3c4216f.flac?ts=1721548161","artist":"Music Assistant","album":null,"uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/cf9413e22d20473fa50ca1b7c3c4216f.flac?ts=1721548161","trackType":""}
Jul 21 09:49:22 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:22 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:22 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:22 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:22 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 9ms
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 4ms
Jul 21 09:49:22 volumio volumio[836]: info: sendMpdCommand status took 3 milliseconds
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:22 volumio volumio[836]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 21 09:49:22 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:22 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:22 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:22 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:22 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"562 Kbps","isStreaming":false,"title":"cf9413e22d20473fa50ca1b7c3c4216f.flac?ts=1721548161","artist":"Music Assistant","album":null,"uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/cf9413e22d20473fa50ca1b7c3c4216f.flac?ts=1721548161","trackType":""}
Jul 21 09:49:22 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:22 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:22 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:22 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:22 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:22 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:22 volumio volumio[836]: info: ------------------------------ 8ms
Jul 21 09:49:25 volumio volumio[836]: info:
Jul 21 09:49:25 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:25 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:25 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:25 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:49:25 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:25 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:25 volumio volumio[836]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 21 09:49:25 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:25 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:25 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:25 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:25 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:25 volumio volumio[836]: info: ------------------------------ 4ms
Jul 21 09:49:25 volumio volumio[836]: info: Clearing queue after UPNP request
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::ClearQueue
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::stop
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock
Jul 21 09:49:25 volumio volumio[836]: info: CorePlayQueue::getTrackBlock
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:25 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:25 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::serviceStop
Jul 21 09:49:25 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:25 volumio volumio[836]: info: ControllerMpd::stop
Jul 21 09:49:25 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 09:49:25 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue
Jul 21 09:49:25 volumio volumio[836]: info: CorePlayQueue::saveQueue
Jul 21 09:49:25 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:25 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue
Jul 21 09:49:25 volumio volumio[836]: info:
Jul 21 09:49:25 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:25 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:25 volumio volumio[836]: info: sendMpdCommand stop took 18 milliseconds
Jul 21 09:49:25 volumio volumio[836]: error: updateQueue error: null
Jul 21 09:49:25 volumio volumio[836]: info: ------------------------------ 2ms
Jul 21 09:49:25 volumio volumio[836]: info: Starting UPNP Playback
Jul 21 09:49:25 volumio volumio[836]: info: Preparing playback through UPNP
Jul 21 09:49:25 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:25 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:25 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:26 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:26 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:26 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:26 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:26 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 2ms
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 2ms
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:26 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:26 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:26 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 21 09:49:26 volumio volumio[836]: info: sendMpdCommand status took 15 milliseconds
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:26 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:26 volumio volumio[836]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 09:49:26 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:26 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:26 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:26 volumio volumio[836]: 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":"Avenue","artist":"Agnes Obel","album":"Philharmonics","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/9ada48979b934c8e82f546846e8a5746.flac?ts=1721548165","trackType":""}
Jul 21 09:49:26 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 20ms
Jul 21 09:49:26 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:26 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:26 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:26 volumio volumio[836]: 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":"Avenue","artist":"Agnes Obel","album":"Philharmonics","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/9ada48979b934c8e82f546846e8a5746.flac?ts=1721548165","trackType":""}
Jul 21 09:49:26 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:26 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 20ms
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:26 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:26 volumio volumio[836]: info:
Jul 21 09:49:26 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:26 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 7ms
Jul 21 09:49:26 volumio volumio[836]: info: sendMpdCommand status took 7 milliseconds
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:26 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:26 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:26 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:26 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:26 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"402 Kbps","isStreaming":false,"title":"9ada48979b934c8e82f546846e8a5746.flac?ts=1721548165","artist":"Music Assistant","album":null,"uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/9ada48979b934c8e82f546846e8a5746.flac?ts=1721548165","trackType":""}
Jul 21 09:49:26 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:26 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:26 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:26 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:26 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:26 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:26 volumio volumio[836]: info: ------------------------------ 10ms
Jul 21 09:49:27 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:27 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:27 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:27 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:49:27 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:49:27 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:49:27 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:27 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:49:27 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:49:27 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:27 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:49:27 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:27 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:27 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:49:27 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:27 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:49:27 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:49:27 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:27 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:31 volumio nmbd[623]: [2024/07/21 09:49:31.811348, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jul 21 09:49:31 volumio nmbd[623]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.112 for name WORKGROUP<1d>.
Jul 21 09:49:31 volumio nmbd[623]: This response was from IP 192.168.1.210, reporting an IP address of 192.168.1.210.
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:36 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:36 volumio volumio[836]: info: sendMpdCommand status took 0 milliseconds
Jul 21 09:49:36 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:36 volumio volumio[836]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 21 09:49:36 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:36 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:36 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:36 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 5ms
Jul 21 09:49:36 volumio volumio[836]: info: Clearing queue after UPNP request
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::ClearQueue
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::stop
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock
Jul 21 09:49:36 volumio volumio[836]: info: CorePlayQueue::getTrackBlock
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:36 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:49:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::serviceStop
Jul 21 09:49:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:36 volumio volumio[836]: info: ControllerMpd::stop
Jul 21 09:49:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 09:49:36 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue
Jul 21 09:49:36 volumio volumio[836]: info: CorePlayQueue::saveQueue
Jul 21 09:49:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:36 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:36 volumio volumio[836]: info: sendMpdCommand stop took 18 milliseconds
Jul 21 09:49:36 volumio volumio[836]: error: updateQueue error: null
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 2ms
Jul 21 09:49:36 volumio volumio[836]: info: Starting UPNP Playback
Jul 21 09:49:36 volumio volumio[836]: info: Preparing playback through UPNP
Jul 21 09:49:36 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:36 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:36 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:36 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 2ms
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:36 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:36 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:36 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:36 volumio volumio[836]: info:
Jul 21 09:49:36 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:36 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:36 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:37 volumio volumio[836]: info:
Jul 21 09:49:37 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:37 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:37 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 21 09:49:37 volumio volumio[836]: info:
Jul 21 09:49:37 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:37 volumio volumio[836]: info: sendMpdCommand status took 15 milliseconds
Jul 21 09:49:37 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:37 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:49:37 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:37 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:37 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:37 volumio volumio[836]: 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":"Aventine","artist":"Agnes Obel","album":"Aventine","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/09a575fe52ba49e185e20768c30b42d0.flac?ts=1721548175","trackType":""}
Jul 21 09:49:37 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 09:49:37 volumio volumio[836]: info: ------------------------------ 18ms
Jul 21 09:49:37 volumio volumio[836]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:37 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:37 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:37 volumio volumio[836]: 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":"Aventine","artist":"Agnes Obel","album":"Aventine","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/09a575fe52ba49e185e20768c30b42d0.flac?ts=1721548175","trackType":""}
Jul 21 09:49:37 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:37 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:37 volumio volumio[836]: info: ------------------------------ 19ms
Jul 21 09:49:37 volumio volumio[836]: info:
Jul 21 09:49:37 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:37 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:37 volumio volumio[836]: info:
Jul 21 09:49:37 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:37 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:37 volumio volumio[836]: info: ------------------------------ 8ms
Jul 21 09:49:37 volumio volumio[836]: info: sendMpdCommand status took 7 milliseconds
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:37 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:37 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:37 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:37 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:37 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"619 Kbps","isStreaming":false,"title":"09a575fe52ba49e185e20768c30b42d0.flac?ts=1721548175","artist":"Music Assistant","album":null,"uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/09a575fe52ba49e185e20768c30b42d0.flac?ts=1721548175","trackType":""}
Jul 21 09:49:37 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:37 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:37 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:37 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:37 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:37 volumio volumio[836]: info: ------------------------------ 11ms
Jul 21 09:49:37 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:37 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:37 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:37 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:49:37 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:49:37 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:49:37 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:37 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:49:37 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:49:37 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:37 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:49:37 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:37 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:37 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:49:37 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:37 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:49:37 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:49:37 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:37 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:37 volumio volumio[836]: info: Listing playlists
Jul 21 09:49:44 volumio volumio[836]: info:
Jul 21 09:49:44 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:44 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:44 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:44 volumio volumio[836]: info: sendMpdCommand status took 0 milliseconds
Jul 21 09:49:44 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:44 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:44 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:44 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:44 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:44 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:44 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:44 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:44 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:44 volumio volumio[836]: info: ------------------------------ 4ms
Jul 21 09:49:44 volumio volumio[836]: info: Clearing queue after UPNP request
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::ClearQueue
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::stop
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock
Jul 21 09:49:45 volumio volumio[836]: info: CorePlayQueue::getTrackBlock
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:45 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:45 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:49:45 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::serviceStop
Jul 21 09:49:45 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:45 volumio volumio[836]: info: ControllerMpd::stop
Jul 21 09:49:45 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 09:49:45 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue
Jul 21 09:49:45 volumio volumio[836]: info: CorePlayQueue::saveQueue
Jul 21 09:49:45 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:45 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue
Jul 21 09:49:45 volumio volumio[836]: info:
Jul 21 09:49:45 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:45 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:45 volumio volumio[836]: info: sendMpdCommand stop took 15 milliseconds
Jul 21 09:49:45 volumio volumio[836]: error: updateQueue error: null
Jul 21 09:49:45 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:45 volumio volumio[836]: info: Starting UPNP Playback
Jul 21 09:49:45 volumio volumio[836]: info: Preparing playback through UPNP
Jul 21 09:49:45 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:45 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:45 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 21 09:49:45 volumio volumio[836]: info:
Jul 21 09:49:45 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:45 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:45 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:45 volumio volumio[836]: info:
Jul 21 09:49:45 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:45 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:45 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:45 volumio volumio[836]: info:
Jul 21 09:49:45 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:45 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:45 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:45 volumio volumio[836]: info:
Jul 21 09:49:45 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:45 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:45 volumio volumio[836]: info: ------------------------------ 0ms
Jul 21 09:49:45 volumio volumio[836]: info:
Jul 21 09:49:45 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:45 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:45 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:45 volumio volumio[836]: info:
Jul 21 09:49:45 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:45 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:45 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:49:46 volumio volumio[836]: info:
Jul 21 09:49:46 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:46 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:46 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 21 09:49:46 volumio volumio[836]: info:
Jul 21 09:49:46 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:46 volumio volumio[836]: info: sendMpdCommand status took 15 milliseconds
Jul 21 09:49:46 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:46 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:49:46 volumio volumio[836]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:46 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:46 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:46 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Broken Sleep","artist":"Agnes Obel","album":"Myopia","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/1ec3f217e7c847158df548d66c59cd23.flac?ts=1721548184","trackType":""}
Jul 21 09:49:46 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 09:49:46 volumio volumio[836]: info: ------------------------------ 19ms
Jul 21 09:49:46 volumio volumio[836]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:46 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:46 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:46 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Broken Sleep","artist":"Agnes Obel","album":"Myopia","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/1ec3f217e7c847158df548d66c59cd23.flac?ts=1721548184","trackType":""}
Jul 21 09:49:46 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:46 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:49:46 volumio volumio[836]: info: ------------------------------ 19ms
Jul 21 09:49:46 volumio volumio[836]: info:
Jul 21 09:49:46 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:49:46 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:49:46 volumio volumio[836]: info:
Jul 21 09:49:46 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:49:46 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:49:46 volumio volumio[836]: info: ------------------------------ 3ms
Jul 21 09:49:46 volumio volumio[836]: info: sendMpdCommand status took 2 milliseconds
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:49:46 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:49:46 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:49:46 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:49:46 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:49:46 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1374 Kbps","isStreaming":false,"title":"1ec3f217e7c847158df548d66c59cd23.flac?ts=1721548184","artist":"Music Assistant","album":null,"uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/1ec3f217e7c847158df548d66c59cd23.flac?ts=1721548184","trackType":""}
Jul 21 09:49:46 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:49:46 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:49:46 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:49:46 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:49:46 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:46 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:46 volumio volumio[836]: info: ------------------------------ 6ms
Jul 21 09:49:47 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:47 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:47 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:47 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:49:47 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:49:47 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:49:47 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:47 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:49:47 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:49:47 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:47 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:49:47 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:47 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:47 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:49:47 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:47 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:49:47 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:49:47 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:47 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:57 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:49:57 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:49:57 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:49:57 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:49:57 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:49:57 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:49:57 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:57 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:49:57 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:49:57 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:57 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:49:57 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:57 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:57 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:49:57 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:49:57 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:49:57 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:49:57 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:49:57 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:49:57 volumio volumio[836]: info: Listing playlists
Jul 21 09:49:57 volumio volumio[836]: info: Listing playlists
Jul 21 09:50:07 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:50:07 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:07 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:50:07 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:50:07 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:50:07 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:50:07 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:07 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:50:07 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:50:07 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:07 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:50:07 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:07 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:07 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:50:07 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:07 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:50:07 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:50:07 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:07 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:17 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:50:17 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:17 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:50:17 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:50:17 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:50:17 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:50:17 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:17 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:50:17 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:50:17 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:17 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:50:17 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:17 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:17 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:50:17 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:17 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:50:17 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:50:17 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:17 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:17 volumio volumio[836]: info: Listing playlists
Jul 21 09:50:17 volumio volumio[836]: info: Listing playlists
Jul 21 09:50:27 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:50:27 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:27 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:50:27 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:50:27 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:50:27 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:50:27 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:27 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:50:27 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:50:27 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:27 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:50:27 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:27 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:27 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:50:27 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:27 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:50:27 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:50:27 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:27 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:29 volumio volumio[836]: info:
Jul 21 09:50:29 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:50:29 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:50:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:50:29 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:50:29 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:50:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:50:29 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:50:29 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:50:29 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:50:29 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:50:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:29 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:50:29 volumio volumio[836]: info: ------------------------------ 4ms
Jul 21 09:50:29 volumio volumio[836]: info: Clearing queue after UPNP request
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::ClearQueue
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::stop
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock
Jul 21 09:50:29 volumio volumio[836]: info: CorePlayQueue::getTrackBlock
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:50:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:29 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:50:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::serviceStop
Jul 21 09:50:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:29 volumio volumio[836]: info: ControllerMpd::stop
Jul 21 09:50:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop
Jul 21 09:50:29 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue
Jul 21 09:50:29 volumio volumio[836]: info: CorePlayQueue::saveQueue
Jul 21 09:50:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:50:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue
Jul 21 09:50:29 volumio volumio[836]: info:
Jul 21 09:50:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:29 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:29 volumio volumio[836]: info: sendMpdCommand stop took 18 milliseconds
Jul 21 09:50:29 volumio volumio[836]: error: updateQueue error: null
Jul 21 09:50:29 volumio volumio[836]: info: ------------------------------ 4ms
Jul 21 09:50:29 volumio volumio[836]: info: Starting UPNP Playback
Jul 21 09:50:29 volumio volumio[836]: info: Preparing playback through UPNP
Jul 21 09:50:29 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:50:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 21 09:50:29 volumio volumio[836]: info:
Jul 21 09:50:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:29 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:30 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:30 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 0ms
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:30 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:30 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 0ms
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:30 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 1ms
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:50:30 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:50:30 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Jul 21 09:50:30 volumio volumio[836]: info: sendMpdCommand status took 15 milliseconds
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:50:30 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:50:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 09:50:30 volumio volumio[836]: info: sendMpdCommand status took 1 milliseconds
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:50:30 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:50:30 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:50:30 volumio volumio[836]: 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":"Only Love","artist":"Ben Howard","album":"Every Kingdom","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/49742064ba084e2eac01d5abc550d33e.flac?ts=1721548229","trackType":""}
Jul 21 09:50:30 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 20ms
Jul 21 09:50:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:50:30 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:50:30 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:50:30 volumio volumio[836]: 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":"Only Love","artist":"Ben Howard","album":"Every Kingdom","uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/49742064ba084e2eac01d5abc550d33e.flac?ts=1721548229","trackType":""}
Jul 21 09:50:30 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:50:30 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 17ms
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update
Jul 21 09:50:30 volumio volumio[836]: info: Ignoring MPD Status Update
Jul 21 09:50:30 volumio volumio[836]: info:
Jul 21 09:50:30 volumio volumio[836]: ---------------------------- MPD announces state update: player
Jul 21 09:50:30 volumio volumio[836]: info: ControllerMpd::getState
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 7ms
Jul 21 09:50:30 volumio volumio[836]: info: sendMpdCommand status took 7 milliseconds
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::parseState
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 21 09:50:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 21 09:50:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo
Jul 21 09:50:30 volumio volumio[836]: info: ControllerMpd::pushState
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState
Jul 21 09:50:30 volumio volumio[836]: verbose: In UPNP mode
Jul 21 09:50:30 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"668 Kbps","isStreaming":false,"title":"49742064ba084e2eac01d5abc550d33e.flac?ts=1721548229","artist":"Music Assistant","album":null,"uri":"http://192.168.1.210:8097/single/uuid:548a2cb5-2925-37ea-1818-dca6320e423b/49742064ba084e2eac01d5abc550d33e.flac?ts=1721548229","trackType":""}
Jul 21 09:50:30 volumio volumio[836]: verbose: CURRENT POSITION 0
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play
Jul 21 09:50:30 volumio volumio[836]: info: Received an update from plugin. extracting info from payload
Jul 21 09:50:30 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 21 09:50:30 volumio volumio[836]: info: CoreStateMachine::pushState
Jul 21 09:50:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:30 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined
Jul 21 09:50:30 volumio volumio[836]: info: ------------------------------ 10ms
Jul 21 09:50:37 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:50:37 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:37 volumio volumio[836]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined
Jul 21 09:50:37 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:50:37 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:50:37 volumio volumio[836]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37)
Jul 21 09:50:37 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:37 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/route.js:137:13)
Jul 21 09:50:37 volumio volumio[836]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3)
Jul 21 09:50:37 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:37 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:281:22
Jul 21 09:50:37 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:37 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:37 volumio volumio[836]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7)
Jul 21 09:50:37 volumio volumio[836]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5)
Jul 21 09:50:37 volumio volumio[836]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13)
Jul 21 09:50:37 volumio volumio[836]: at /volumio/node_modules/express/lib/router/index.js:284:7
Jul 21 09:50:37 volumio volumio[836]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12)
Jul 21 09:50:37 volumio volumio[836]: at next (/volumio/node_modules/express/lib/router/index.js:275:10)
Jul 21 09:50:37 volumio volumio[836]: info: Listing playlists
Jul 21 09:50:37 volumio volumio[836]: info: Listing playlists
Jul 21 09:50:47 volumio sudo[4766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 21 09:50:47 volumio sudo[4766]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 09:50:47 volumio sudo[4766]: pam_unix(sudo:session): session closed for user root
Jul 21 09:50:47 volumio sudo[4768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 21 09:50:47 volumio sudo[4768]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 21 09:50:47 volumio sudo[4768]: pam_unix(sudo:session): session closed for user root
Jul 21 09:50:47 volumio volumio[836]: verbose: New Socket.io Connection to 192.168.1.112 from 192.168.1.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:128.0) Gecko/20100101 Firefox/128.0 Total Clients: 5
Jul 21 09:50:47 volumio volumio[836]: info: CoreCommandRouter::volumioGetState
Jul 21 09:50:47 volumio volumio[836]: info: CorePlayQueue::getTrack 0
Jul 21 09:50:47 volumio volumio[836]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 21 09:50:47 volumio volumio[836]: TypeError: Cannot read property 'name' of undefined
Jul 21 09:50:47 volumio volumio[836]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48)
Jul 21 09:50:47 volumio volumio[836]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:106:28)
Jul 21 09:50:47 volumio volumio[836]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:53:38)
Jul 21 09:50:47 volumio volumio[836]: at Socket.emit (events.js:315:20)
Jul 21 09:50:47 volumio volumio[836]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Jul 21 09:50:47 volumio volumio[836]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jul 21 09:50:47 volumio volumio[836]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 21 09:50:47 volumio sudo[4782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 09:49
Jul 21 09:50:47 volumio sudo[4782]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST"
VOLUMIO_VERSION="3.512"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"