Mar 24 17:32:10 volumiopi3 volumio[20286]: info: CALLMETHOD: music_service jellyfin configSaveMyMediaLibrarySettings [object Object] Mar 24 17:32:10 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: jellyfin , configSaveMyMediaLibrarySettings Mar 24 17:32:13 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 24 17:32:13 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 24 17:32:33 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioGetState Mar 24 17:32:33 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:39 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Mar 24 17:32:39 volumiopi3 volumio[20286]: info: [jellyfin-browse] browseUri: jellyfin Mar 24 17:32:39 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:42 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Mar 24 17:32:42 volumiopi3 volumio[20286]: info: [jellyfin-browse] browseUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62 Mar 24 17:32:42 volumiopi3 volumio[20286]: info: [jellyfin-conn] Generated new device Id for mfpie@d789701e4fa8: 0d5af971-4930-4c17-b2d3-d57fa8bf1014 Mar 24 17:32:42 volumiopi3 volumio[20286]: info: [jellyfin-conn] Login successful: mfpie@d789701e4fa8 Mar 24 17:32:42 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"07ed8d6fc5804337bf5363a28c604ef0","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"startIndex":0,"limit":47,"sortBy":["SortName"],"sortOrder":["Ascending"]} Mar 24 17:32:42 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.1.205:8097/UserViews?userId=07ed8d6fc5804337bf5363a28c604ef0 Mar 24 17:32:42 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"07ed8d6fc5804337bf5363a28c604ef0","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"7e64e319657a9516ec78490da03edccb","startIndex":0,"limit":11,"sortBy":["DateCreated","SortName"],"sortOrder":["Descending","Ascending"],"includeItemTypes":["MusicAlbum"]} Mar 24 17:32:42 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.1.205:8097/Items?userId=07ed8d6fc5804337bf5363a28c604ef0&startIndex=0&limit=11&recursive=true&sortOrder=Descending&sortOrder=Ascending&parentId=7e64e319657a9516ec78490da03edccb&includeItemTypes=MusicAlbum&sortBy=DateCreated&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Mar 24 17:32:42 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:42 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:45 volumiopi3 nmbd[3455]: [2026/03/24 17:32:45.834235, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 24 17:32:45 volumiopi3 nmbd[3455]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.209 for name WORKGROUP<1d>. Mar 24 17:32:45 volumiopi3 nmbd[3455]: This response was from IP 192.168.1.205, reporting an IP address of 192.168.1.205. Mar 24 17:32:48 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Mar 24 17:32:48 volumiopi3 volumio[20286]: info: [jellyfin-browse] browseUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e Mar 24 17:32:48 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"07ed8d6fc5804337bf5363a28c604ef0","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"8d8363e4699d1481eb7baef42319157e","startIndex":0,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"includeItemTypes":["Audio"]} Mar 24 17:32:48 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.1.205:8097/Items?userId=07ed8d6fc5804337bf5363a28c604ef0&startIndex=0&recursive=true&sortOrder=Ascending&parentId=8d8363e4699d1481eb7baef42319157e&fields=MediaSources&includeItemTypes=Audio&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=575fbf1098a366a11df07c03844f5c94 Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=06249dbc142bc397ac00452f0b474cda Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=31eebe2893d0645179302a49a98b3665 Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=830048e493474a12465ae23ce6e578c1 Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=02a37b91f33f662086f325d76fdc33f3 in service jellyfin Mar 24 17:32:48 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:48 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:32:48 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=575fbf1098a366a11df07c03844f5c94 in service jellyfin Mar 24 17:32:48 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=575fbf1098a366a11df07c03844f5c94 Mar 24 17:32:48 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:32:48 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:32:48 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:32:48 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=06249dbc142bc397ac00452f0b474cda in service jellyfin Mar 24 17:32:48 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=06249dbc142bc397ac00452f0b474cda Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=31eebe2893d0645179302a49a98b3665 in service jellyfin Mar 24 17:32:48 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=31eebe2893d0645179302a49a98b3665 Mar 24 17:32:48 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=830048e493474a12465ae23ce6e578c1 in service jellyfin Mar 24 17:32:48 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=830048e493474a12465ae23ce6e578c1 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::ClearQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::clearPlayQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::addQueueItems Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::addQueueItems Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPlay Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::play index 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::addQueueItems Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::addQueueItems Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=575fbf1098a366a11df07c03844f5c94 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=575fbf1098a366a11df07c03844f5c94 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=06249dbc142bc397ac00452f0b474cda Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=06249dbc142bc397ac00452f0b474cda Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=31eebe2893d0645179302a49a98b3665 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=31eebe2893d0645179302a49a98b3665 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=830048e493474a12465ae23ce6e578c1 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=830048e493474a12465ae23ce6e578c1 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::play index undefined Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::startPlaybackTimer Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: [jellyfin-play] Stream URL for Jailbreak: http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand stop took 2 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand clear Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand clear took 4 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3" Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 12ms Mar 24 17:32:50 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:32:50 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand addid "http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3" Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 61ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 60ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand addid "http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3" took 3 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 11ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 5ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 5ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 10ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand play took 7 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 7ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 5ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: [jellyfin-play]: Mark song Jailbreak as played by mfpie. Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 29 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 36 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 33 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 30 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Mar 24 17:32:50 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 54 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 57ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 52 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 45 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 45 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 50 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 21ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 18 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 16ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand status took 15 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 168ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 210ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 207ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 153 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 153 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 150 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 149 milliseconds Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:50 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 372ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 327ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: ------------------------------ 325ms Mar 24 17:32:50 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:32:50 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'start' for song: Jailbreak (at 0 ms) Mar 24 17:32:50 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'timeupdate' for song: Jailbreak (at 881 ms) Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::ClearQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::serviceStop Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::serviceStop Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::stop Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::clearPlayQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::addQueueItems Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::addQueueItems Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPlay Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::play index 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::addQueueItems Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::addQueueItems Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=575fbf1098a366a11df07c03844f5c94 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=575fbf1098a366a11df07c03844f5c94 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=06249dbc142bc397ac00452f0b474cda Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=06249dbc142bc397ac00452f0b474cda Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=31eebe2893d0645179302a49a98b3665 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=31eebe2893d0645179302a49a98b3665 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=830048e493474a12465ae23ce6e578c1 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=8d8363e4699d1481eb7baef42319157e/song@songId=830048e493474a12465ae23ce6e578c1 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::play index undefined Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::startPlaybackTimer Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/song@songId=02a37b91f33f662086f325d76fdc33f3 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand stop took 53 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand status took 9 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand status took 6 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand status took 5 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand status took 3 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:53 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ------------------------------ 62ms Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ------------------------------ 59ms Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ------------------------------ 58ms Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:32:53 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'stop' for song: Jailbreak (at 4052 ms) Mar 24 17:32:53 volumiopi3 volumio[20286]: info: [jellyfin-play] Stream URL for Jailbreak: http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand stop took 0 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand clear Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand clear took 1 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3" Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:53 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ------------------------------ 5ms Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand addid "http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3" Mar 24 17:32:53 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:32:53 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ------------------------------ 18ms Mar 24 17:32:53 volumiopi3 volumio[20286]: info: ------------------------------ 17ms Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:53 volumiopi3 volumio[20286]: info: sendMpdCommand addid "http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3" took 3 milliseconds Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:32:53 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:32:53 volumiopi3 volumio[20286]: info: Mar 24 17:32:53 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 6ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 4ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 3ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 6ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand play took 5 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 4ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 3ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: info: [jellyfin-play]: Mark song Jailbreak as played by mfpie. Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 26 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 34 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 31 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 30 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 27 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 24 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 24 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 21 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 68ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Mar 24 17:32:54 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 35ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 30 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 27ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand status took 25 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 19 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 19 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":538,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":847,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 211ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 205ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 190ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 196 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 189ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 174 milliseconds Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":870,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":283,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jailbreak","artist":"AC-DC","album":"74 Jailbreak","uri":"http://192.168.1.205:8097/Audio/02a37b91f33f662086f325d76fdc33f3/stream.mp3?static=true&mediaSourceId=02a37b91f33f662086f325d76fdc33f3&tag=82583ee7b8c312397f2019ca2042cacd&t.mp3","trackType":"mp3"} Mar 24 17:32:54 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 0 Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:32:54 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 303ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: ------------------------------ 289ms Mar 24 17:32:54 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'timeupdate' for song: Jailbreak (at 618 ms) Mar 24 17:32:54 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'start' for song: Jailbreak (at 480 ms) Mar 24 17:33:28 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Mar 24 17:33:28 volumiopi3 volumio[20286]: info: [jellyfin-browse] browseUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5 Mar 24 17:33:28 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"07ed8d6fc5804337bf5363a28c604ef0","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"0234d431f6d6cd5964b57058b25576e5","startIndex":0,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"includeItemTypes":["Audio"]} Mar 24 17:33:28 volumiopi3 volumio[20286]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.1.205:8097/Items?userId=07ed8d6fc5804337bf5363a28c604ef0&startIndex=0&recursive=true&sortOrder=Ascending&parentId=0234d431f6d6cd5964b57058b25576e5&fields=MediaSources&includeItemTypes=Audio&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=788062f61232f66134d531e6d5e2f777 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=77c13f72d31adce119b565be6ebfbea4 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=d7bb3654da50ab58d6c357b6c37c746b Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=e65532e782809656b018633006821944 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=2264c1a9d3071fc3d99a242b6b35a180 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=8b888efeb466fbc923cee6dc13425d9b Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=11bf54887b181f11a994dcac14150565 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=575ef9fbdd6d37369f5f16aa89f9f3cd Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=5fd7be85f5e45eae66098e1068bf2943 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Preloading song: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=6f9c3fad151131f6f55a591698b87a27 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=788062f61232f66134d531e6d5e2f777 in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=788062f61232f66134d531e6d5e2f777 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:33:29 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:33:29 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:33:29 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=77c13f72d31adce119b565be6ebfbea4 in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=77c13f72d31adce119b565be6ebfbea4 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:33:29 volumiopi3 volumio[20286]: info: No valid Plugin REST Endpoint Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=d7bb3654da50ab58d6c357b6c37c746b in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=d7bb3654da50ab58d6c357b6c37c746b Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=e65532e782809656b018633006821944 in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=e65532e782809656b018633006821944 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=2264c1a9d3071fc3d99a242b6b35a180 in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=2264c1a9d3071fc3d99a242b6b35a180 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=8b888efeb466fbc923cee6dc13425d9b in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=8b888efeb466fbc923cee6dc13425d9b Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=11bf54887b181f11a994dcac14150565 in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=11bf54887b181f11a994dcac14150565 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=575ef9fbdd6d37369f5f16aa89f9f3cd in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=575ef9fbdd6d37369f5f16aa89f9f3cd Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=5fd7be85f5e45eae66098e1068bf2943 in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=5fd7be85f5e45eae66098e1068bf2943 Mar 24 17:33:29 volumiopi3 volumio[20286]: info: Exploding uri jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=6f9c3fad151131f6f55a591698b87a27 in service jellyfin Mar 24 17:33:29 volumiopi3 volumio[20286]: info: [jellyfin-browse] explodeUri: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=6f9c3fad151131f6f55a591698b87a27 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::ClearQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::serviceStop Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::serviceStop Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::stop Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::clearPlayQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::addQueueItems Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::addQueueItems Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=788062f61232f66134d531e6d5e2f777 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=788062f61232f66134d531e6d5e2f777 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=77c13f72d31adce119b565be6ebfbea4 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=77c13f72d31adce119b565be6ebfbea4 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=d7bb3654da50ab58d6c357b6c37c746b Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=d7bb3654da50ab58d6c357b6c37c746b Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=e65532e782809656b018633006821944 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=e65532e782809656b018633006821944 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPlay Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::play index 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::addQueueItems Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::addQueueItems Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=2264c1a9d3071fc3d99a242b6b35a180 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=2264c1a9d3071fc3d99a242b6b35a180 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=8b888efeb466fbc923cee6dc13425d9b Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=8b888efeb466fbc923cee6dc13425d9b Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=11bf54887b181f11a994dcac14150565 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=11bf54887b181f11a994dcac14150565 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=575ef9fbdd6d37369f5f16aa89f9f3cd Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=575ef9fbdd6d37369f5f16aa89f9f3cd Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=5fd7be85f5e45eae66098e1068bf2943 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=5fd7be85f5e45eae66098e1068bf2943 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Adding Item to queue: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=6f9c3fad151131f6f55a591698b87a27 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Using cached record of: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/songs@albumId=0234d431f6d6cd5964b57058b25576e5/song@songId=6f9c3fad151131f6f55a591698b87a27 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::play index undefined Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::startPlaybackTimer Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/mfpie@98f7c509406e44f8852d4d9b1ee1cd62/song@songId=e65532e782809656b018633006821944 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand stop took 55 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 6 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 5 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 3 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 3 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 49ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 48ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 47ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:33:31 volumiopi3 volumio[20286]: info: [jellyfin-play] Stream URL for Give The Dog A Bone: http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:33:31 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'stop' for song: Jailbreak (at 38073 ms) Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand stop took 3 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand clear Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand clear took 1 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3" Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 5ms Mar 24 17:33:31 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:33:31 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand addid "http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3" Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 49ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 47ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand addid "http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3" took 1 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: MPD COMMAND [object Object] Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 6ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 4ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 3ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 6ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand play took 4 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 3ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 3ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: [jellyfin-play]: Mark song Give The Dog A Bone as played by mfpie. Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 24 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 27 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 25 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 23 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 8 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 9 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 7 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 44ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Mar 24 17:33:31 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 17 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 19ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 14 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ------------------------------ 10ms Mar 24 17:33:31 volumiopi3 volumio[20286]: info: sendMpdCommand status took 10 milliseconds Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":171,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:31 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:31 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:31 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 237ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 234ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 217ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 215ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Mar 24 17:33:32 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Mar 24 17:33:32 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:32 volumiopi3 volumio[20286]: info: sendMpdCommand status took 232 milliseconds Mar 24 17:33:32 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 223 milliseconds Mar 24 17:33:32 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 223 milliseconds Mar 24 17:33:32 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 222 milliseconds Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 8ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: sendMpdCommand status took 6 milliseconds Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 330ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 319ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Pushing Favourites {"favourite":false} Mar 24 17:33:32 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 168 milliseconds Mar 24 17:33:32 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 166 milliseconds Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1087,"duration":212,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Give The Dog A Bone","artist":"AC-DC","album":"Back In Black","uri":"http://192.168.1.205:8097/Audio/e65532e782809656b018633006821944/stream.mp3?static=true&mediaSourceId=e65532e782809656b018633006821944&tag=0ae66458b89a77b2122dd8a30741d68e&t.mp3","trackType":"mp3"} Mar 24 17:33:32 volumiopi3 volumio[20286]: verbose: CURRENT POSITION 3 Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState stateService play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:33:32 volumiopi3 volumio[20286]: info: Received an update from plugin. extracting info from payload Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 484ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: ------------------------------ 258ms Mar 24 17:33:32 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'start' for song: Give The Dog A Bone (at 0 ms) Mar 24 17:33:32 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'timeupdate' for song: Give The Dog A Bone (at 0 ms) Mar 24 17:33:32 volumiopi3 volumio[20286]: info: [jellyfin-play]: Reported 'timeupdate' for song: Give The Dog A Bone (at 881 ms) Mar 24 17:33:36 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume19 Mar 24 17:33:36 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:36 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:36 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:37 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume58 Mar 24 17:33:37 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:37 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:37 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:38 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume69 Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:38 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume73 Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:38 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume81 Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:38 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:39 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume4 Mar 24 17:33:39 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:39 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:39 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:40 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume5 Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:40 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume11 Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:40 volumiopi3 volumio[20286]: info: VolumeController::SetAlsaVolume13 Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:40 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:48 volumiopi3 dhcpcd[803]: eth0: failed to renew DHCP, rebinding Mar 24 17:33:48 volumiopi3 dhcpcd[803]: eth0: leased 192.168.1.209 for 3600 seconds Mar 24 17:33:48 volumiopi3 systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Mar 24 17:33:48 volumiopi3 systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Mar 24 17:33:48 volumiopi3 systemd[1]: welcome.service: Deactivated successfully. Mar 24 17:33:48 volumiopi3 systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 24 17:33:48 volumiopi3 systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 24 17:33:48 volumiopi3 systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 24 17:33:48 volumiopi3 welcome[1661]: Resolved ip:[1] 192.168.1.209 Mar 24 17:33:48 volumiopi3 systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 24 17:33:48 volumiopi3 systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Mar 24 17:33:49 volumiopi3 volumio[20286]: info: Received Get System Info Mar 24 17:33:49 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 17:33:49 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 17:33:49 volumiopi3 volumio[20286]: info: Discovery: Getting this device information Mar 24 17:33:49 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioGetState Mar 24 17:33:49 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 17:33:49 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 24 17:33:49 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 24 17:33:50 volumiopi3 volumio5-onboarding[1871]: time=2026-03-25T00:33:50.197Z level=INFO msg="service successfully established" component=discovery/localnet Mar 24 17:33:52 volumiopi3 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 24 17:33:54 volumiopi3 systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 24 17:33:54 volumiopi3 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 24 17:33:56 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , handleBrowseUri Mar 24 17:33:56 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::ClearQueue Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::serviceStop Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 3 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::serviceStop Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::stop Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::clearPlayQueue Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::addQueueItems Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::addQueueItems Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Preload queue cleared Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Adding Item to queue: webrp/2 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Exploding uri webrp/2 in service radio_paradise Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::saveQueue Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::updateTrackBlock Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrackBlock Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPlay Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::play index 0 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::stop Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::play index undefined Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::startPlaybackTimer Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: [RadioParadise] Matched station: Radio Paradise Rock Mix (FLAC), chan=2 Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Mar 24 17:33:58 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand stop took 37 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand stop took 14 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand clear Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Mar 24 17:33:58 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Mar 24 17:33:58 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: player Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Mar 24 17:33:58 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand status took 8 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand status took 7 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand clear took 5 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand status took 4 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand status took 3 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand consume 1 Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::pushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::servicePushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreStateMachine::pushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CoreCommandRouter::volumioPushState Mar 24 17:33:58 volumiopi3 volumio[20286]: info: CorePlayQueue::getTrack 0 Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ------------------------------ 40ms Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ------------------------------ 38ms Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Mar 24 17:33:58 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Mar 24 17:33:58 volumiopi3 volumio[20286]: ---------------------------- MPD announces system playlist update Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Ignoring MPD Status Update Mar 24 17:33:58 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:33:58 volumiopi3 volumio[20286]: info: Mar 24 17:33:58 volumiopi3 volumio[20286]: ---------------------------- MPD announces state update: options Mar 24 17:33:58 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:33:58 volumiopi3 volumio[20286]: error: updateQueue error: null Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ------------------------------ 42ms Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 40 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand playlistinfo took 40 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: sendMpdCommand consume 1 took 40 milliseconds Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ControllerMpd::getState Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ------------------------------ 6ms Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ------------------------------ 6ms Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:33:58 volumiopi3 volumio[20286]: info: [1774398838780] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/rock-flacm Mar 24 17:33:58 volumiopi3 volumio[20286]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/rock-flacm" Mar 24 17:33:58 volumiopi3 volumio[20286]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 24 17:33:58 volumiopi3 volumio[20286]: info: ------------------------------ 54ms Mar 24 17:33:58 volumiopi3 volumio[20286]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 17:33:58 volumiopi3 volumio[20286]: TypeError: Cannot read properties of undefined (reading 'split') Mar 24 17:33:58 volumiopi3 volumio[20286]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60) Mar 24 17:33:58 volumiopi3 volumio[20286]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 24 17:33:58 volumiopi3 volumio[20286]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Mar 24 17:33:58 volumiopi3 volumio[20286]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 17:33:59 volumiopi3 sudo[1721]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-24 17:32' Mar 24 17:33:59 volumiopi3 sudo[1721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"