Jan 09 11:46:44 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::ClearQueue Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::serviceStop Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::serviceStop Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::stop Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::clearPlayQueue Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::addQueueItems Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::addQueueItems Jan 09 11:46:44 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:44 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=cdfb4e9abf6656afa0c6be7b718126f4 Jan 09 11:46:44 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=cdfb4e9abf6656afa0c6be7b718126f4 Jan 09 11:46:44 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6a6e838ef89db397849dcf09bdc9e32c Jan 09 11:46:44 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6a6e838ef89db397849dcf09bdc9e32c Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPlay Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::play index 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::addQueueItems Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::addQueueItems Jan 09 11:46:44 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:44 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=13ba96e003b76ea37f86d3d9f52cfc25 Jan 09 11:46:44 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=13ba96e003b76ea37f86d3d9f52cfc25 Jan 09 11:46:44 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6c8715f0b2fd59d9acc1dbcd1744beea Jan 09 11:46:44 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6c8715f0b2fd59d9acc1dbcd1744beea Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::play index undefined Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/song@songId=6a6e838ef89db397849dcf09bdc9e32c Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand stop took 9 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 8ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 7ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 7ms Jan 09 11:46:44 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:44 rockola volumio[1292]: info: [jellyfin-play] Stream URL for LeAnn Rimes - Please Remember: https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9 Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand stop took 0 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand clear took 0 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand load "https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3" Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:44 rockola volumio[1292]: info: [jellyfin-play]: Reported 'stop' for song: LeAnn Rimes - Can't Fight The Moonlight (at 51751 ms) Jan 09 11:46:44 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:44 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3" Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 58ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 58ms Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand addid "https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3" took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:44 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:44 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 0ms Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand play took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:44 rockola volumio[1292]: info: [jellyfin-play]: Mark song LeAnn Rimes - Please Remember as played by jjeffries. Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 21 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - Please Remember","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3","trackType":"mp3"} Jan 09 11:46:44 rockola volumio[1292]: verbose: CURRENT POSITION 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 23ms Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:44 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:44 rockola volumio[1292]: info: Jan 09 11:46:44 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 2 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 2ms Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 2 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":275,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - Please Remember","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3","trackType":"mp3"} Jan 09 11:46:44 rockola volumio[1292]: verbose: CURRENT POSITION 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:44 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":137,"duration":275,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - Please Remember","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3","trackType":"mp3"} Jan 09 11:46:44 rockola volumio[1292]: verbose: CURRENT POSITION 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:44 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 30ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 30ms Jan 09 11:46:44 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 9ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 9ms Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand status took 8 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":275,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - Please Remember","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3","trackType":"mp3"} Jan 09 11:46:44 rockola volumio[1292]: verbose: CURRENT POSITION 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:44 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":275,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - Please Remember","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3","trackType":"mp3"} Jan 09 11:46:44 rockola volumio[1292]: verbose: CURRENT POSITION 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:44 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 14ms Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 14ms Jan 09 11:46:44 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:44 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 09 11:46:44 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:44 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:44 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:44 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":275,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - Please Remember","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6a6e838ef89db397849dcf09bdc9e32c/stream.mp3?static=true&mediaSourceId=6a6e838ef89db397849dcf09bdc9e32c&tag=275be132b5fa15060ed16a1d2e083db9&t.mp3","trackType":"mp3"} Jan 09 11:46:44 rockola volumio[1292]: verbose: CURRENT POSITION 1 Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:44 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:44 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:44 rockola volumio[1292]: info: ------------------------------ 17ms Jan 09 11:46:44 rockola volumio[1292]: info: [jellyfin-play]: Reported 'start' for song: LeAnn Rimes - Please Remember (at 103 ms) Jan 09 11:46:44 rockola volumio[1292]: info: [jellyfin-play]: Reported 'timeupdate' for song: LeAnn Rimes - Please Remember (at 881 ms) Jan 09 11:46:48 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::ClearQueue Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::serviceStop Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 1 Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::serviceStop Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::stop Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::clearPlayQueue Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::addQueueItems Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::addQueueItems Jan 09 11:46:48 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:48 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=cdfb4e9abf6656afa0c6be7b718126f4 Jan 09 11:46:48 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=cdfb4e9abf6656afa0c6be7b718126f4 Jan 09 11:46:48 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6a6e838ef89db397849dcf09bdc9e32c Jan 09 11:46:48 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6a6e838ef89db397849dcf09bdc9e32c Jan 09 11:46:48 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=13ba96e003b76ea37f86d3d9f52cfc25 Jan 09 11:46:48 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=13ba96e003b76ea37f86d3d9f52cfc25 Jan 09 11:46:48 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6c8715f0b2fd59d9acc1dbcd1744beea Jan 09 11:46:48 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6c8715f0b2fd59d9acc1dbcd1744beea Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPlay Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::play index 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::play index undefined Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/song@songId=6c8715f0b2fd59d9acc1dbcd1744beea Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand stop took 8 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 4ms Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 3ms Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 3ms Jan 09 11:46:48 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:48 rockola volumio[1292]: info: [jellyfin-play]: Reported 'stop' for song: LeAnn Rimes - Please Remember (at 4773 ms) Jan 09 11:46:48 rockola volumio[1292]: info: [jellyfin-play] Stream URL for LeAnn Rimes - But I Do Love You: https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87 Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand stop took 0 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand clear took 0 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand load "https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3" Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:48 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:48 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3" Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 55ms Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 55ms Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand addid "https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3" took 0 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:48 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:48 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 2ms Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 2ms Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand play took 2 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 2ms Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 0ms Jan 09 11:46:48 rockola volumio[1292]: info: [jellyfin-play]: Mark song LeAnn Rimes - But I Do Love You as played by jjeffries. Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 21 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 21 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - But I Do Love You","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3","trackType":"mp3"} Jan 09 11:46:48 rockola volumio[1292]: verbose: CURRENT POSITION 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 23ms Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:48 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:48 rockola volumio[1292]: info: Jan 09 11:46:48 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:48 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:48 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - But I Do Love You","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3","trackType":"mp3"} Jan 09 11:46:48 rockola volumio[1292]: verbose: CURRENT POSITION 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:48 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:48 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:48 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:48 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":103,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - But I Do Love You","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3","trackType":"mp3"} Jan 09 11:46:48 rockola volumio[1292]: verbose: CURRENT POSITION 3 Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:48 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:48 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:49 rockola volumio[1292]: info: ------------------------------ 26ms Jan 09 11:46:49 rockola volumio[1292]: info: ------------------------------ 25ms Jan 09 11:46:49 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:49 rockola volumio[1292]: info: Jan 09 11:46:49 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:49 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:49 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:46:49 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:46:49 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:46:49 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:46:49 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:49 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:49 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:49 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:49 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:49 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:49 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:49 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - But I Do Love You","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3","trackType":"mp3"} Jan 09 11:46:49 rockola volumio[1292]: verbose: CURRENT POSITION 3 Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:49 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:49 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:49 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:49 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - But I Do Love You","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3","trackType":"mp3"} Jan 09 11:46:49 rockola volumio[1292]: verbose: CURRENT POSITION 3 Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:49 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:49 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:49 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:49 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":201,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - But I Do Love You","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/6c8715f0b2fd59d9acc1dbcd1744beea/stream.mp3?static=true&mediaSourceId=6c8715f0b2fd59d9acc1dbcd1744beea&tag=65ac86374d9baa3f0726f0374cc6fc87&t.mp3","trackType":"mp3"} Jan 09 11:46:49 rockola volumio[1292]: verbose: CURRENT POSITION 3 Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:49 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:49 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:49 rockola volumio[1292]: info: ------------------------------ 9ms Jan 09 11:46:49 rockola volumio[1292]: info: ------------------------------ 8ms Jan 09 11:46:49 rockola volumio[1292]: info: ------------------------------ 8ms Jan 09 11:46:49 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:49 rockola volumio[1292]: info: [jellyfin-play]: Reported 'start' for song: LeAnn Rimes - But I Do Love You (at 80 ms) Jan 09 11:46:49 rockola volumio[1292]: info: [jellyfin-play]: Reported 'timeupdate' for song: LeAnn Rimes - But I Do Love You (at 881 ms) Jan 09 11:46:52 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::ClearQueue Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::serviceStop Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 3 Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::serviceStop Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::stop Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::clearPlayQueue Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::addQueueItems Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::addQueueItems Jan 09 11:46:52 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:52 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=cdfb4e9abf6656afa0c6be7b718126f4 Jan 09 11:46:52 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=cdfb4e9abf6656afa0c6be7b718126f4 Jan 09 11:46:52 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6a6e838ef89db397849dcf09bdc9e32c Jan 09 11:46:52 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6a6e838ef89db397849dcf09bdc9e32c Jan 09 11:46:52 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=13ba96e003b76ea37f86d3d9f52cfc25 Jan 09 11:46:52 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=13ba96e003b76ea37f86d3d9f52cfc25 Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPlay Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::play index 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::addQueueItems Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::addQueueItems Jan 09 11:46:52 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:46:52 rockola volumio[1292]: info: Adding Item to queue: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6c8715f0b2fd59d9acc1dbcd1744beea Jan 09 11:46:52 rockola volumio[1292]: info: Using cached record of: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/songs@search=leann%20rimes@collatedSearchResults=1/song@songId=6c8715f0b2fd59d9acc1dbcd1744beea Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::play index undefined Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/song@songId=13ba96e003b76ea37f86d3d9f52cfc25 Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand stop took 8 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 0 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 4ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 3ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 3ms Jan 09 11:46:52 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:52 rockola volumio[1292]: info: [jellyfin-play]: Reported 'stop' for song: LeAnn Rimes - But I Do Love You (at 3910 ms) Jan 09 11:46:52 rockola volumio[1292]: info: [jellyfin-play] Stream URL for LeAnn Rimes - The Right Kind Of Wrong: https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand stop took 0 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand clear took 0 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand load "https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3" Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:52 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:52 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand addid "https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3" Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 26ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 26ms Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand addid "https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3" took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:52 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:52 rockola volumio[1292]: verbose: MPD COMMAND [object Object] Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 0ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 0ms Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand play Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 2ms Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand play took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:52 rockola volumio[1292]: info: [jellyfin-play]: Mark song LeAnn Rimes - The Right Kind Of Wrong as played by jjeffries. Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 22 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 23 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 23 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 23 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:46:52 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus stop Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 25ms Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:46:52 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:46:52 rockola volumio[1292]: info: Jan 09 11:46:52 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 1ms Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:46:52 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:52 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":103,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:46:52 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:52 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 27ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 27ms Jan 09 11:46:52 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 5ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 5ms Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand status took 5 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:46:52 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:52 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:46:52 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:52 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 9ms Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 8ms Jan 09 11:46:52 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:46:52 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 09 11:46:52 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:46:52 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:46:52 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:46:52 rockola volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:46:52 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState stateService play Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus play Jan 09 11:46:52 rockola volumio[1292]: info: Received an update from plugin. extracting info from payload Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:46:52 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:46:52 rockola volumio[1292]: info: ------------------------------ 12ms Jan 09 11:46:52 rockola volumio[1292]: info: [jellyfin-play]: Reported 'start' for song: LeAnn Rimes - The Right Kind Of Wrong (at 68 ms) Jan 09 11:46:52 rockola volumio[1292]: info: [jellyfin-play]: Reported 'timeupdate' for song: LeAnn Rimes - The Right Kind Of Wrong (at 881 ms) Jan 09 11:46:54 rockola ntpd[1133]: PROTO: 66.118.231.14 unlink local addr 192.168.2.19 -> Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::volumioPause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::pause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::servicePause Jan 09 11:47:01 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::servicePause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::pause Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand pause Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand pause took 2 milliseconds Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:01 rockola volumio[1292]: info: Jan 09 11:47:01 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:01 rockola volumio[1292]: info: Jan 09 11:47:01 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:01 rockola volumio[1292]: info: Jan 09 11:47:01 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand status took 3 milliseconds Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand status took 2 milliseconds Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand status took 2 milliseconds Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand status took 2 milliseconds Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:47:01 rockola volumio[1292]: info: Pushing Favourites {"favourite":false} Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:47:01 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:47:01 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:47:01 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:47:01 rockola volumio[1292]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10077,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:47:01 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::syncState stateService pause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus pause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:47:01 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:47:01 rockola volumio[1292]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10077,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:47:01 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::syncState stateService pause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus pause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:47:01 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:47:01 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:47:01 rockola volumio[1292]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":10077,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"LeAnn Rimes - The Right Kind Of Wrong","artist":"Various Artists","album":"Coyote Ugly Soundtrack","uri":"https://music.jjeffries.com/Audio/13ba96e003b76ea37f86d3d9f52cfc25/stream.mp3?static=true&mediaSourceId=13ba96e003b76ea37f86d3d9f52cfc25&tag=4132c92d8c9030ed59d4e83066d1f9fc&t.mp3","trackType":"mp3"} Jan 09 11:47:01 rockola volumio[1292]: verbose: CURRENT POSITION 2 Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::syncState stateService pause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::syncState currentStatus pause Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:47:01 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:47:01 rockola volumio[1292]: info: ------------------------------ 13ms Jan 09 11:47:01 rockola volumio[1292]: info: ------------------------------ 12ms Jan 09 11:47:01 rockola volumio[1292]: info: ------------------------------ 12ms Jan 09 11:47:01 rockola volumio[1292]: info: Pushing Favourites {"service":"mpd","uri":"jellyfin/jjeffries@71c93ae0b56f45139e8742a862279bd9/song@songId=13ba96e003b76ea37f86d3d9f52cfc25","favourite":false} Jan 09 11:47:01 rockola volumio[1292]: info: [jellyfin-play]: Reported 'pause' for song: LeAnn Rimes - The Right Kind Of Wrong (at 10077 ms) Jan 09 11:47:10 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 09 11:47:10 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:47:12 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 09 11:47:12 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:47:13 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::ClearQueue Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::stPlaybackTimer Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::serviceStop Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 2 Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::serviceStop Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 11:47:13 rockola volumio[1292]: info: ControllerMpd::stop Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::clearPlayQueue Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::addQueueItems Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::addQueueItems Jan 09 11:47:13 rockola volumio[1292]: info: Preload queue cleared Jan 09 11:47:13 rockola volumio[1292]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99592593 Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::volumioPushQueue Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::saveQueue Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::updateTrackBlock Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrackBlock Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::volumioPlay Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::play index 0 Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::stop Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::play index undefined Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::startPlaybackTimer Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:47:13 rockola volumio[1292]: info: [1767977233409] ControllerWebradio::clearAddPlayTrack Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand stop Jan 09 11:47:13 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:13 rockola volumio[1292]: info: Jan 09 11:47:13 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand stop took 4 milliseconds Jan 09 11:47:13 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand stop took 1 milliseconds Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand clear Jan 09 11:47:13 rockola volumio[1292]: info: Jan 09 11:47:13 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:47:13 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:13 rockola volumio[1292]: info: Jan 09 11:47:13 rockola volumio[1292]: ---------------------------- MPD announces state update: player Jan 09 11:47:13 rockola volumio[1292]: info: ControllerMpd::getState Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Jan 09 11:47:13 rockola volumio[1292]: info: Jan 09 11:47:13 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:47:13 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand clear took 1 milliseconds Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand status took 1 milliseconds Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99592593" Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::parseState Jan 09 11:47:13 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:47:13 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 11:47:13 rockola volumio[1292]: info: ControllerMpd::pushState Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::servicePushState Jan 09 11:47:13 rockola volumio[1292]: info: CoreStateMachine::pushState Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:47:13 rockola volumio[1292]: info: CoreCommandRouter::volumioPushState Jan 09 11:47:13 rockola volumio[1292]: info: CorePlayQueue::getTrack 0 Jan 09 11:47:13 rockola volumio[1292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 09 11:47:13 rockola volumio[1292]: info: ------------------------------ 5ms Jan 09 11:47:13 rockola volumio[1292]: info: ------------------------------ 5ms Jan 09 11:47:13 rockola volumio[1292]: info: Jan 09 11:47:13 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:47:13 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:47:13 rockola volumio[1292]: info: Jan 09 11:47:13 rockola volumio[1292]: ---------------------------- MPD announces system playlist update Jan 09 11:47:13 rockola volumio[1292]: info: Ignoring MPD Status Update Jan 09 11:47:13 rockola volumio[1292]: error: updateQueue error: null Jan 09 11:47:13 rockola volumio[1292]: info: ------------------------------ 4ms Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 09 11:47:13 rockola volumio[1292]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:47:13 rockola volumio[1292]: verbose: ControllerMpd::parseTrackInfo Jan 09 11:47:13 rockola volumio[1292]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 11:47:13 rockola volumio[1292]: info: ------------------------------ 6ms Jan 09 11:47:13 rockola volumio[1292]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 11:47:13 rockola volumio[1292]: TypeError: Cannot read properties of undefined (reading 'split') Jan 09 11:47:13 rockola volumio[1292]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60) Jan 09 11:47:13 rockola volumio[1292]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 09 11:47:13 rockola volumio[1292]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 09 11:47:13 rockola volumio[1292]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 11:47:13 rockola sudo[6443]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 11:46' Jan 09 11:47:13 rockola sudo[6443]: 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"