Dec 06 11:01:09 volumio volumio[1142]: info: CALLMETHOD: music_service jellyfin configSaveBrowseSettings [object Object] Dec 06 11:01:09 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: jellyfin , configSaveBrowseSettings Dec 06 11:01:35 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 06 11:01:35 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 06 11:01:38 volumio volumio[1142]: info: CoreCommandRouter::volumioGetState Dec 06 11:01:38 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:01:41 volumio volumio[1142]: info: CoreCommandRouter::volumioGetQueue Dec 06 11:01:41 volumio volumio[1142]: info: CoreStateMachine::getQueue Dec 06 11:01:41 volumio volumio[1142]: info: CorePlayQueue::getQueue Dec 06 11:01:43 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 06 11:01:43 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:01:46 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Dec 06 11:01:46 volumio volumio[1142]: Error Retrieving last played file: Error: /data/laststates.json: ENOENT: no such file or directory, open '/data/laststates.json' Dec 06 11:01:46 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:01:48 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 06 11:01:48 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:01:50 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 06 11:01:50 volumio volumio[1142]: info: CURURI: genres:// Dec 06 11:01:50 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:01:53 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Dec 06 11:01:53 volumio volumio[1142]: info: [jellyfin-browse] browseUri: jellyfin Dec 06 11:01:53 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:01:55 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Dec 06 11:01:55 volumio volumio[1142]: info: [jellyfin-browse] browseUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53 Dec 06 11:01:55 volumio volumio[1142]: info: [jellyfin-conn] Generated new device Id for kurage@Jellyfin: 76dbfc6d-1f7f-401e-bb15-5cc52f4d4faf Dec 06 11:01:55 volumio volumio[1142]: info: [jellyfin-conn] Login successful: kurage@Jellyfin Dec 06 11:01:55 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:01:55 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:01:55 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:02 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Dec 06 11:02:02 volumio volumio[1142]: info: [jellyfin-browse] browseUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c Dec 06 11:02:02 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:02 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:02 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=03d7989c923d66643a24ea0be029584a Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=40463f2d89f98e88612d8a056d8301bb Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=239731481069ee289f40d03f43ec04d1 Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=86f918637ed6d7f5f7a85027f719fb5f Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=3b98537d323973e92f451a38470da0dc Dec 06 11:02:02 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=86f918637ed6d7f5f7a85027f719fb5f Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=4badc5119991dc29c357bca95cd7c6da Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=26dd37ac1b85769b87af9950170026d6 Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=6a00623d353f1d3bd4e424c2775a148b Dec 06 11:02:02 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=3b98537d323973e92f451a38470da0dc Dec 06 11:02:02 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=86f918637ed6d7f5f7a85027f719fb5f in service jellyfin Dec 06 11:02:02 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=86f918637ed6d7f5f7a85027f719fb5f Dec 06 11:02:02 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=4badc5119991dc29c357bca95cd7c6da in service jellyfin Dec 06 11:02:02 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=4badc5119991dc29c357bca95cd7c6da Dec 06 11:02:03 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=26dd37ac1b85769b87af9950170026d6 in service jellyfin Dec 06 11:02:03 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=26dd37ac1b85769b87af9950170026d6 Dec 06 11:02:03 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=6a00623d353f1d3bd4e424c2775a148b in service jellyfin Dec 06 11:02:03 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=6a00623d353f1d3bd4e424c2775a148b Dec 06 11:02:03 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=3b98537d323973e92f451a38470da0dc in service jellyfin Dec 06 11:02:03 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/song@songId=3b98537d323973e92f451a38470da0dc Dec 06 11:02:10 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Dec 06 11:02:10 volumio volumio[1142]: info: [jellyfin-browse] browseUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd Dec 06 11:02:10 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:10 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=17763d02188b2e9729898d79b9b58915 Dec 06 11:02:10 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=c5b968909412ad7eab16b7a6c726c0c3 Dec 06 11:02:10 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=780256deaba273ad5f7c032dd2fae624 Dec 06 11:02:10 volumio volumio[1142]: info: Preloading song: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=1b9f88adaef86e8ab980b92fc7920d9a Dec 06 11:02:10 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:10 volumio volumio[1142]: info: No valid Plugin REST Endpoint Dec 06 11:02:35 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::ClearQueue Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::stop Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::clearPlayQueue Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::saveQueue Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::addQueueItems Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::addQueueItems Dec 06 11:02:35 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:35 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=17763d02188b2e9729898d79b9b58915 Dec 06 11:02:35 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=17763d02188b2e9729898d79b9b58915 in service jellyfin Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=17763d02188b2e9729898d79b9b58915 Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::saveQueue Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPlay Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::play index 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::addQueueItems Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::addQueueItems Dec 06 11:02:35 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:35 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=c5b968909412ad7eab16b7a6c726c0c3 Dec 06 11:02:35 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=c5b968909412ad7eab16b7a6c726c0c3 in service jellyfin Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=c5b968909412ad7eab16b7a6c726c0c3 Dec 06 11:02:35 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=780256deaba273ad5f7c032dd2fae624 Dec 06 11:02:35 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=780256deaba273ad5f7c032dd2fae624 in service jellyfin Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=780256deaba273ad5f7c032dd2fae624 Dec 06 11:02:35 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=1b9f88adaef86e8ab980b92fc7920d9a Dec 06 11:02:35 volumio volumio[1142]: info: Exploding uri jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=1b9f88adaef86e8ab980b92fc7920d9a in service jellyfin Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-browse] explodeUri: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=1b9f88adaef86e8ab980b92fc7920d9a Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::stop Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::play index undefined Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::startPlaybackTimer Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/song@songId=17763d02188b2e9729898d79b9b58915 Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-play] Stream URL for voyage1969 feat.Beastie Boys: http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1 Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::saveQueue Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand stop took 9 milliseconds Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand clear took 2 milliseconds Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3" Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: error: updateQueue error: null Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 8ms Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand addid "http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3" Dec 06 11:02:35 volumio volumio[1142]: error: updateQueue error: null Dec 06 11:02:35 volumio volumio[1142]: error: updateQueue error: null Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 31ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 31ms Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand addid "http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3" took 2 milliseconds Dec 06 11:02:35 volumio volumio[1142]: verbose: MPD COMMAND [object Object] Dec 06 11:02:35 volumio volumio[1142]: verbose: MPD COMMAND [object Object] Dec 06 11:02:35 volumio volumio[1142]: verbose: MPD COMMAND [object Object] Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 8ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 6ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 6ms Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand play Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 6ms Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand play took 4 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 3ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 3ms Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-play]: Mark song voyage1969 feat.Beastie Boys as played by kurage. Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 48 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 47 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 51 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 57 milliseconds Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 40 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 31 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 40ms Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 13 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 13ms Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand status took 12 milliseconds Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"voyage1969 feat.Beastie Boys","artist":"haru","album":"viotex","uri":"http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3","trackType":"mp3"} Dec 06 11:02:35 volumio volumio[1142]: verbose: CURRENT POSITION 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus stop Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"voyage1969 feat.Beastie Boys","artist":"haru","album":"viotex","uri":"http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3","trackType":"mp3"} Dec 06 11:02:35 volumio volumio[1142]: verbose: CURRENT POSITION 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:02:35 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"voyage1969 feat.Beastie Boys","artist":"haru","album":"viotex","uri":"http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3","trackType":"mp3"} Dec 06 11:02:35 volumio volumio[1142]: verbose: CURRENT POSITION 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:02:35 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 116ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 110ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 108ms Dec 06 11:02:35 volumio volumio[1142]: info: Pushing Favourites {"favourite":false} Dec 06 11:02:35 volumio volumio[1142]: info: Dec 06 11:02:35 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:35 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 40 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 40 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 38 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 39 milliseconds Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 5ms Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"voyage1969 feat.Beastie Boys","artist":"haru","album":"viotex","uri":"http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3","trackType":"mp3"} Dec 06 11:02:35 volumio volumio[1142]: verbose: CURRENT POSITION 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:02:35 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"voyage1969 feat.Beastie Boys","artist":"haru","album":"viotex","uri":"http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3","trackType":"mp3"} Dec 06 11:02:35 volumio volumio[1142]: verbose: CURRENT POSITION 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:02:35 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:35 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:35 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":240,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"voyage1969 feat.Beastie Boys","artist":"haru","album":"viotex","uri":"http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3","trackType":"mp3"} Dec 06 11:02:35 volumio volumio[1142]: verbose: CURRENT POSITION 0 Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play Dec 06 11:02:35 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 103ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 76ms Dec 06 11:02:35 volumio volumio[1142]: info: ------------------------------ 74ms Dec 06 11:02:35 volumio volumio[1142]: info: Pushing Favourites {"favourite":false} Dec 06 11:02:35 volumio volumio[1142]: info: CoreCommandRouter::volumioGetState Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-play]: Reported 'timeupdate' for song: voyage1969 feat.Beastie Boys (at 858 ms) Dec 06 11:02:35 volumio volumio[1142]: info: [jellyfin-play]: Reported 'start' for song: voyage1969 feat.Beastie Boys (at 57 ms) Dec 06 11:02:39 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::ClearQueue Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::stop Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::stPlaybackTimer Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::serviceStop Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::serviceStop Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 11:02:39 volumio volumio[1142]: info: ControllerMpd::stop Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::clearPlayQueue Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::saveQueue Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::addQueueItems Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::addQueueItems Dec 06 11:02:39 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:39 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=17763d02188b2e9729898d79b9b58915 Dec 06 11:02:39 volumio volumio[1142]: info: Using cached record of: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=17763d02188b2e9729898d79b9b58915 Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::saveQueue Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioPlay Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::play index 0 Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::addQueueItems Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::addQueueItems Dec 06 11:02:39 volumio volumio[1142]: info: Preload queue cleared Dec 06 11:02:39 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=c5b968909412ad7eab16b7a6c726c0c3 Dec 06 11:02:39 volumio volumio[1142]: info: Using cached record of: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=c5b968909412ad7eab16b7a6c726c0c3 Dec 06 11:02:39 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=780256deaba273ad5f7c032dd2fae624 Dec 06 11:02:39 volumio volumio[1142]: info: Using cached record of: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=780256deaba273ad5f7c032dd2fae624 Dec 06 11:02:39 volumio volumio[1142]: info: Adding Item to queue: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=1b9f88adaef86e8ab980b92fc7920d9a Dec 06 11:02:39 volumio volumio[1142]: info: Using cached record of: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/library@parentId=553f66c4fe1b928c068181d06e16a22c/songs@albumId=a34e690141a391a7d611d1519f1018fd/song@songId=1b9f88adaef86e8ab980b92fc7920d9a Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::stop Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::saveQueue Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::play index undefined Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::startPlaybackTimer Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/kurage@cbb5b8d2d90f4935bab536ed8469ab53/song@songId=17763d02188b2e9729898d79b9b58915 Dec 06 11:02:39 volumio volumio[1142]: info: [jellyfin-play] Stream URL for voyage1969 feat.Beastie Boys: http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1 Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand stop took 36 milliseconds Dec 06 11:02:39 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:39 volumio volumio[1142]: info: Dec 06 11:02:39 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:39 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand stop took 15 milliseconds Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 11:02:39 volumio volumio[1142]: info: Dec 06 11:02:39 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:39 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:39 volumio volumio[1142]: info: Dec 06 11:02:39 volumio volumio[1142]: ---------------------------- MPD announces state update: player Dec 06 11:02:39 volumio volumio[1142]: info: ControllerMpd::getState Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status Dec 06 11:02:39 volumio volumio[1142]: info: Dec 06 11:02:39 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:39 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand status took 4 milliseconds Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand clear took 3 milliseconds Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand status took 3 milliseconds Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand status took 2 milliseconds Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3" Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::parseState Dec 06 11:02:39 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Dec 06 11:02:39 volumio volumio[1142]: info: ControllerMpd::pushState Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::servicePushState Dec 06 11:02:39 volumio volumio[1142]: info: CoreStateMachine::pushState Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState Dec 06 11:02:39 volumio volumio[1142]: info: CorePlayQueue::getTrack 0 Dec 06 11:02:39 volumio volumio[1142]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Dec 06 11:02:39 volumio volumio[1142]: info: ------------------------------ 12ms Dec 06 11:02:39 volumio volumio[1142]: info: ------------------------------ 12ms Dec 06 11:02:39 volumio volumio[1142]: info: Dec 06 11:02:39 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:39 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:39 volumio volumio[1142]: info: Dec 06 11:02:39 volumio volumio[1142]: ---------------------------- MPD announces system playlist update Dec 06 11:02:39 volumio volumio[1142]: info: Ignoring MPD Status Update Dec 06 11:02:39 volumio volumio[1142]: error: updateQueue error: null Dec 06 11:02:39 volumio volumio[1142]: error: updateQueue error: null Dec 06 11:02:39 volumio volumio[1142]: error: updateQueue error: null Dec 06 11:02:39 volumio volumio[1142]: info: ------------------------------ 16ms Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 06 11:02:39 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand addid "http://192.168.1.5:8899/Audio/17763d02188b2e9729898d79b9b58915/stream.mp3?static=true&mediaSourceId=17763d02188b2e9729898d79b9b58915&tag=f9a2b3bcc3642209d08d3487db8d62e1&t.mp3" Dec 06 11:02:39 volumio volumio[1142]: info: ------------------------------ 6ms Dec 06 11:02:39 volumio volumio[1142]: info: ------------------------------ 5ms Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:39 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo Dec 06 11:02:39 volumio volumio[1142]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 06 11:02:39 volumio volumio[1142]: info: ------------------------------ 22ms Dec 06 11:02:39 volumio volumio[1142]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 11:02:39 volumio volumio[1142]: TypeError: Cannot read properties of undefined (reading 'split') Dec 06 11:02:39 volumio volumio[1142]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60) Dec 06 11:02:39 volumio volumio[1142]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 06 11:02:39 volumio volumio[1142]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 06 11:02:39 volumio volumio[1142]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 11:02:40 volumio sudo[26966]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-06 11:01' Dec 06 11:02:40 volumio sudo[26966]: 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="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 2 11:51:19 UTC 2025" VOLUMIO_VERSION="4.072" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e5001581b220b096097cf8f46a54d4f1"