Jan 09 14:26:24 volumio volumio[1098]: info: [jellyfin-poller] Polled http://192.168.8.117:8096: online Jan 09 14:26:28 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jan 09 14:26:29 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Jan 09 14:26:29 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jan 09 14:26:57 volumio sudo[4325]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 09 14:26:57 volumio sudo[4325]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 14:26:57 volumio sudo[4325]: pam_unix(sudo:session): session closed for user root Jan 09 14:26:57 volumio sudo[4327]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 14:26:57 volumio sudo[4327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 14:26:57 volumio sudo[4327]: pam_unix(sudo:session): session closed for user root Jan 09 14:26:57 volumio volumio[1098]: verbose: New Socket.io Connection to 192.168.8.187 from 192.168.8.117 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/114.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:26:58 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 09 14:26:58 volumio volumio[1098]: info: Received Get System Info Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 14:26:58 volumio volumio[1098]: info: Discovery: Getting this device information Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:26:58 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:26:58 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:26:58 volumio volumio[1098]: info: Listing playlists Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 09 14:26:58 volumio sudo[4332]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 09 14:26:58 volumio sudo[4332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 14:26:58 volumio sudo[4332]: pam_unix(sudo:session): session closed for user root Jan 09 14:26:58 volumio sudo[4334]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 14:26:58 volumio sudo[4334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 14:26:58 volumio sudo[4334]: pam_unix(sudo:session): session closed for user root Jan 09 14:26:58 volumio volumio[1098]: verbose: New Socket.io Connection to 192.168.8.187 from 192.168.8.117 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/114.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:26:58 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 09 14:26:58 volumio volumio[1098]: info: Received Get System Info Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 14:26:58 volumio volumio[1098]: info: Discovery: Getting this device information Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:26:58 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:26:58 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:26:58 volumio volumio[1098]: info: Listing playlists Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 14:26:58 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 09 14:26:59 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:26:59 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:00 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 09 14:27:00 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 09 14:27:00 volumio volumio[1098]: info: Received Get System Info Jan 09 14:27:00 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 14:27:00 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 14:27:00 volumio volumio[1098]: info: Discovery: Getting this device information Jan 09 14:27:00 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:27:00 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:00 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 14:27:00 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::play index undefined Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/sameer@c67d14ecdd9d4b52b284d7339a3f7aa2/song@songId=52db521cb93241c270a66e5cf0fdf16f Jan 09 14:27:02 volumio volumio[1098]: info: [jellyfin-play] Stream URL for Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English): http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand stop took 1 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand clear took 1 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3" Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio mpd[1400]: exception: No such playlist Jan 09 14:27:02 volumio volumio[1098]: error: updateQueue error: null Jan 09 14:27:02 volumio volumio[1098]: error: updateQueue error: null Jan 09 14:27:02 volumio volumio[1098]: error: updateQueue error: null Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand addid "http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3" Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 57ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 56ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 55ms Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand addid "http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3" took 1 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: MPD COMMAND [object Object] Jan 09 14:27:02 volumio volumio[1098]: verbose: MPD COMMAND [object Object] Jan 09 14:27:02 volumio volumio[1098]: verbose: MPD COMMAND [object Object] Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 5ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 5ms Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand play took 5 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 4ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 2ms Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:02 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 3ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 2ms Jan 09 14:27:02 volumio mpd[1400]: [src/libmpg123/parse.c:do_readahead():1122] error: cannot seek! Jan 09 14:27:02 volumio mpd[1400]: mpg123: mpg123_getformat() failed: A generic mpg123 error. Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio mpd[1400]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied Jan 09 14:27:02 volumio mpd[1400]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied Jan 09 14:27:02 volumio mpd[1400]: player: problems opening audio device while playing "http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3" Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 15 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 20 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 20 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 20 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: info: Jan 09 14:27:02 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 38 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand clearerror took 30 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 30 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand clearerror took 25 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand clearerror took 25 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand clearerror took 24 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 23 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand status took 23 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":352,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English)","artist":"Emiko Shiratori - Nobuo Uematsu","album":"Final Fantasy IX - Melodies Of Life","uri":"http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3","trackType":"mp3"} Jan 09 14:27:02 volumio volumio[1098]: verbose: CURRENT POSITION 1 Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState stateService pause Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:02 volumio volumio[1098]: info: Pushing Favourites {"service":"mpd","favourite":false} Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":352,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English)","artist":"Emiko Shiratori - Nobuo Uematsu","album":"Final Fantasy IX - Melodies Of Life","uri":"http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3","trackType":"mp3"} Jan 09 14:27:02 volumio volumio[1098]: verbose: CURRENT POSITION 1 Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState stateService pause Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":352,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English)","artist":"Emiko Shiratori - Nobuo Uematsu","album":"Final Fantasy IX - Melodies Of Life","uri":"http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3","trackType":"mp3"} Jan 09 14:27:02 volumio volumio[1098]: verbose: CURRENT POSITION 1 Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState stateService pause Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 120ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 119ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 118ms Jan 09 14:27:02 volumio volumio[1098]: info: Pushing Favourites {"favourite":false} Jan 09 14:27:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 09 14:27:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 09 14:27:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand clearerror took 104 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 85 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 85 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 64 milliseconds Jan 09 14:27:02 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 64 milliseconds Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":352,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English)","artist":"Emiko Shiratori - Nobuo Uematsu","album":"Final Fantasy IX - Melodies Of Life","uri":"http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3","trackType":"mp3"} Jan 09 14:27:02 volumio volumio[1098]: verbose: CURRENT POSITION 1 Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState stateService pause Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":352,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English)","artist":"Emiko Shiratori - Nobuo Uematsu","album":"Final Fantasy IX - Melodies Of Life","uri":"http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3","trackType":"mp3"} Jan 09 14:27:02 volumio volumio[1098]: verbose: CURRENT POSITION 1 Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState stateService pause Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:02 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:02 volumio volumio[1098]: info: CorePlayQueue::getTrack 1 Jan 09 14:27:02 volumio volumio[1098]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":352,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English)","artist":"Emiko Shiratori - Nobuo Uematsu","album":"Final Fantasy IX - Melodies Of Life","uri":"http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3","trackType":"mp3"} Jan 09 14:27:02 volumio volumio[1098]: verbose: CURRENT POSITION 1 Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState stateService pause Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop Jan 09 14:27:02 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:02 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 168ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 139ms Jan 09 14:27:02 volumio volumio[1098]: info: ------------------------------ 138ms Jan 09 14:27:02 volumio volumio[1098]: info: Pushing Favourites {"favourite":false} Jan 09 14:27:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 09 14:27:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 09 14:27:02 volumio volumio[1098]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 09 14:27:02 volumio volumio[1098]: info: [jellyfin-play]: Mark song Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English) as played by sameer. Jan 09 14:27:02 volumio volumio[1098]: info: [jellyfin-play]: Reported 'pause' for song: Emiko Shiratori - Nobuo Uematsu / Melodies Of Life (English) (at 0 ms) Jan 09 14:27:03 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 09 14:27:03 volumio volumio[1098]: info: Received Get System Info Jan 09 14:27:03 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 14:27:03 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 14:27:03 volumio volumio[1098]: info: Discovery: Getting this device information Jan 09 14:27:03 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:27:03 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 14:27:08 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 09 14:27:13 volumio volumio[1098]: info: CoreCommandRouter::volumioGetQueue Jan 09 14:27:13 volumio volumio[1098]: info: CoreStateMachine::getQueue Jan 09 14:27:13 volumio volumio[1098]: info: CorePlayQueue::getQueue Jan 09 14:27:15 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Jan 09 14:27:15 volumio volumio[1098]: info: [jellyfin-browse] browseUri: jellyfin Jan 09 14:27:15 volumio volumio[1098]: info: Preload queue cleared Jan 09 14:27:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 14:27:16 volumio volumio[1098]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 09 14:27:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 09 14:27:16 volumio volumio[1098]: info: Received Get System Version Jan 09 14:27:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 14:27:16 volumio volumio[1098]: info: Received Get System Info Jan 09 14:27:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 14:27:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 14:27:16 volumio volumio[1098]: info: Discovery: Getting this device information Jan 09 14:27:16 volumio volumio[1098]: info: CoreCommandRouter::volumioGetState Jan 09 14:27:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 14:27:17 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Jan 09 14:27:17 volumio volumio[1098]: info: [jellyfin-browse] browseUri: jellyfin/sameer@c67d14ecdd9d4b52b284d7339a3f7aa2 Jan 09 14:27:17 volumio volumio[1098]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"df083fc42b7649f5848cf856fde3cfd5","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"startIndex":0,"limit":47,"sortBy":["SortName"],"sortOrder":["Ascending"]} Jan 09 14:27:17 volumio volumio[1098]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.8.117:8096/UserViews?userId=df083fc42b7649f5848cf856fde3cfd5 Jan 09 14:27:17 volumio volumio[1098]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"df083fc42b7649f5848cf856fde3cfd5","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"7e64e319657a9516ec78490da03edccb","startIndex":0,"limit":11,"sortBy":["DateCreated","SortName"],"sortOrder":["Descending","Ascending"],"includeItemTypes":["MusicAlbum"]} Jan 09 14:27:17 volumio volumio[1098]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.8.117:8096/Items?userId=df083fc42b7649f5848cf856fde3cfd5&startIndex=0&limit=11&recursive=true&sortOrder=Descending&sortOrder=Ascending&parentId=7e64e319657a9516ec78490da03edccb&includeItemTypes=MusicAlbum&sortBy=DateCreated&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Jan 09 14:27:17 volumio volumio[1098]: info: Preload queue cleared Jan 09 14:27:17 volumio volumio[1098]: info: Preload queue cleared Jan 09 14:27:21 volumio volumio[1098]: info: Preload queue cleared Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::ClearQueue Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::stop Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::clearPlayQueue Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::saveQueue Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::addQueueItems Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::addQueueItems Jan 09 14:27:21 volumio volumio[1098]: info: Preload queue cleared Jan 09 14:27:21 volumio volumio[1098]: info: Adding Item to queue: jellyfin/sameer@c67d14ecdd9d4b52b284d7339a3f7aa2/songs@albumId=b60b21fb96b9b4f425bbabdcbfeb414e Jan 09 14:27:21 volumio volumio[1098]: info: Exploding uri jellyfin/sameer@c67d14ecdd9d4b52b284d7339a3f7aa2/songs@albumId=b60b21fb96b9b4f425bbabdcbfeb414e in service jellyfin Jan 09 14:27:21 volumio volumio[1098]: info: [jellyfin-browse] explodeUri: jellyfin/sameer@c67d14ecdd9d4b52b284d7339a3f7aa2/songs@albumId=b60b21fb96b9b4f425bbabdcbfeb414e Jan 09 14:27:21 volumio volumio[1098]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"df083fc42b7649f5848cf856fde3cfd5","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"b60b21fb96b9b4f425bbabdcbfeb414e","startIndex":0,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"includeItemTypes":["Audio"]} Jan 09 14:27:21 volumio volumio[1098]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.8.117:8096/Items?userId=df083fc42b7649f5848cf856fde3cfd5&startIndex=0&recursive=true&sortOrder=Ascending&parentId=b60b21fb96b9b4f425bbabdcbfeb414e&fields=MediaSources&includeItemTypes=Audio&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::saveQueue Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::play index 0 Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::stop Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::play index undefined Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::getTrack 0 Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::getTrack 0 Jan 09 14:27:21 volumio volumio[1098]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/sameer@c67d14ecdd9d4b52b284d7339a3f7aa2/song@songId=de7bbf170c58fc0646efea2f2aea2f77 Jan 09 14:27:21 volumio volumio[1098]: info: [jellyfin-play] Stream URL for Everyday Is A Winding Road: http://192.168.8.117:8096/Audio/de7bbf170c58fc0646efea2f2aea2f77/stream.m4a?static=true&mediaSourceId=de7bbf170c58fc0646efea2f2aea2f77&tag=c407c86a236c18563478c38cb8aecb4b Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 14:27:21 volumio mpd[1400]: player: played "http://192.168.8.117:8096/Audio/52db521cb93241c270a66e5cf0fdf16f/stream.mp3?static=true&mediaSourceId=52db521cb93241c270a66e5cf0fdf16f&tag=7beb5b9bfe19803a28b5468a0300421e&t.mp3" Jan 09 14:27:21 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:21 volumio volumio[1098]: info: Jan 09 14:27:21 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand stop took 5 milliseconds Jan 09 14:27:21 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 14:27:21 volumio volumio[1098]: info: Jan 09 14:27:21 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:21 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:21 volumio volumio[1098]: info: Jan 09 14:27:21 volumio volumio[1098]: ---------------------------- MPD announces state update: player Jan 09 14:27:21 volumio volumio[1098]: info: ControllerMpd::getState Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status Jan 09 14:27:21 volumio volumio[1098]: info: Jan 09 14:27:21 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:21 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand status took 6 milliseconds Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand status took 5 milliseconds Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand clear took 4 milliseconds Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand status took 3 milliseconds Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.8.117:8096/Audio/de7bbf170c58fc0646efea2f2aea2f77/stream.m4a?static=true&mediaSourceId=de7bbf170c58fc0646efea2f2aea2f77&tag=c407c86a236c18563478c38cb8aecb4b&t.m4a" Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:21 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::getTrack 0 Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::getTrack 0 Jan 09 14:27:21 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 14:27:21 volumio volumio[1098]: info: ------------------------------ 18ms Jan 09 14:27:21 volumio volumio[1098]: info: Jan 09 14:27:21 volumio volumio[1098]: ---------------------------- MPD announces system playlist update Jan 09 14:27:21 volumio volumio[1098]: info: Ignoring MPD Status Update Jan 09 14:27:21 volumio volumio[1098]: error: updateQueue error: null Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand status took 17 milliseconds Jan 09 14:27:21 volumio volumio[1098]: info: ------------------------------ 17ms Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 09 14:27:21 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::parseState Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:21 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo Jan 09 14:27:21 volumio volumio[1098]: info: ControllerMpd::pushState Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::servicePushState Jan 09 14:27:21 volumio volumio[1098]: info: CoreStateMachine::pushState Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::getTrack 0 Jan 09 14:27:21 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState Jan 09 14:27:21 volumio volumio[1098]: info: CorePlayQueue::getTrack 0 Jan 09 14:27:21 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 14:27:21 volumio volumio[1098]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 14:27:21 volumio volumio[1098]: info: ------------------------------ 28ms Jan 09 14:27:21 volumio volumio[1098]: info: ------------------------------ 32ms Jan 09 14:27:21 volumio volumio[1098]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 14:27:21 volumio volumio[1098]: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 14:27:21 volumio volumio[1098]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60) Jan 09 14:27:21 volumio volumio[1098]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 09 14:27:21 volumio volumio[1098]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 09 14:27:21 volumio volumio[1098]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 14:27:21 volumio mpd[1400]: exception: No such playlist Jan 09 14:27:22 volumio sudo[4413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 14:26' Jan 09 14:27:22 volumio sudo[4413]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"