-- Logs begin at Wed 2024-10-02 14:12:50 UTC, end at Fri 2024-10-18 10:24:07 UTC. -- Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioNext Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:01 musical-fidelity volumio[1029]: info: [1729246981165] ControllerTidal::next Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::stop Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:01 musical-fidelity volumio[1029]: verbose: UNSET VOLATILE Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::stPlaybackTimer Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 6 Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::serviceStop Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 6 Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreCommandRouter::serviceStop Oct 18 10:23:01 musical-fidelity volumio[1029]: info: [1729246981173] ControllerTidal::stop Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:01 musical-fidelity volumio[1029]: info: ControllerMpd::stop Oct 18 10:23:01 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:01 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:01 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 108 milliseconds Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::play index undefined Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::startPlaybackTimer Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:01 musical-fidelity volumio[1029]: info: [1729246981285] ControllerTidal::clearAddPlayTrack Oct 18 10:23:01 musical-fidelity volumio[1029]: info: Getting stream with soundQuality HI_RES Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:01 musical-fidelity volumio[1029]: info: Oct 18 10:23:01 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:01 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:01 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:01 musical-fidelity volumio[1029]: info: sendMpdCommand status took 5 milliseconds Oct 18 10:23:01 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:01 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:01 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 18 10:23:01 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:01 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:01 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:01 musical-fidelity volumio[1029]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Oct 18 10:23:01 musical-fidelity volumio[1029]: info: ------------------------------ 21ms Oct 18 10:23:01 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:02 musical-fidelity volumio[1029]: info: getStreamUrl took 869 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 1 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand clear Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Oct 18 10:23:02 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand clear took 1 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidhOGQ5NzJhMDMzOTU1ZmIxODdjMGMwZTdlNjdhZDEyMl82Mi5tcDQ/0.flac?Expires=1729250582&Signature=ka~FVPihgbOb0It6XYJHMyX8K2fGXTQS2HXKl3r~PbD~bu0hZiFaOyhxZ52TDBWOVY~TPcHpMVTNBqYjG1Iga-SiQlMm0KWSBzgxp7TuAEf9zWXvLwIYo9XGZFkbuM5xWNDChNNBlpWWSInlVijcumnRbOa2bOMqayJ9M2pC8unNrXSnYk0gVDoRWxVrPvwXShB8E~rx7BDmo0Nd04KZ4hQ7cc-S~t4HRvShJFompymFytI3cZRHHCGduRRV~L4BiiWk9ana9Deste8WPThZSzJXqPfb7N3edSRIiVzaDNddo5mq-Blx-I033N3BrsyBpr34Sz1S9oRQkP4FKrT6aQ__&Key-Pair-Id=K14LZCZ9QUI4JL" Oct 18 10:23:02 musical-fidelity volumio[1029]: error: updateQueue error: null Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Oct 18 10:23:02 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ------------------------------ 4ms Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidhOGQ5NzJhMDMzOTU1ZmIxODdjMGMwZTdlNjdhZDEyMl82Mi5tcDQ/0.flac?Expires=1729250582&Signature=ka~FVPihgbOb0It6XYJHMyX8K2fGXTQS2HXKl3r~PbD~bu0hZiFaOyhxZ52TDBWOVY~TPcHpMVTNBqYjG1Iga-SiQlMm0KWSBzgxp7TuAEf9zWXvLwIYo9XGZFkbuM5xWNDChNNBlpWWSInlVijcumnRbOa2bOMqayJ9M2pC8unNrXSnYk0gVDoRWxVrPvwXShB8E~rx7BDmo0Nd04KZ4hQ7cc-S~t4HRvShJFompymFytI3cZRHHCGduRRV~L4BiiWk9ana9Deste8WPThZSzJXqPfb7N3edSRIiVzaDNddo5mq-Blx-I033N3BrsyBpr34Sz1S9oRQkP4FKrT6aQ__&Key-Pair-Id=K14LZCZ9QUI4JL" took 13 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand play Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ------------------------------ 14ms Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand play took 2 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Oct 18 10:23:02 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Oct 18 10:23:02 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand status took 11 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand status took 19 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":203,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?Expires=1729250582&Signature=ka~FVPihgbOb0It6XYJHMyX8K2fGXTQS2HXKl3r~PbD~bu0hZiFaOyhxZ52TDBWOVY~TPcHpMVTNBqYjG1Iga-SiQlMm0KWSBzgxp7TuAEf9zWXvLwIYo9XGZFkbuM5xWNDChNNBlpWWSInlVijcumnRbOa2bOMqayJ9M2pC8unNrXSnYk0gVDoRWxVrPvwXShB8E~rx7BDmo0Nd04KZ4hQ7cc-S~t4HRvShJFompymFytI3cZRHHCGduRRV~L4BiiWk9ana9Deste8WPThZSzJXqPfb7N3edSRIiVzaDNddo5mq-Blx-I033N3BrsyBpr34Sz1S9oRQkP4FKrT6aQ__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidhOGQ5NzJhMDMzOTU1ZmIxODdjMGMwZTdlNjdhZDEyMl82Mi5tcDQ/0.flac?Expires=1729250582&Signature=ka~FVPihgbOb0It6XYJHMyX8K2fGXTQS2HXKl3r~PbD~bu0hZiFaOyhxZ52TDBWOVY~TPcHpMVTNBqYjG1Iga-SiQlMm0KWSBzgxp7TuAEf9zWXvLwIYo9XGZFkbuM5xWNDChNNBlpWWSInlVijcumnRbOa2bOMqayJ9M2pC8unNrXSnYk0gVDoRWxVrPvwXShB8E~rx7BDmo0Nd04KZ4hQ7cc-S~t4HRvShJFompymFytI3cZRHHCGduRRV~L4BiiWk9ana9Deste8WPThZSzJXqPfb7N3edSRIiVzaDNddo5mq-Blx-I033N3BrsyBpr34Sz1S9oRQkP4FKrT6aQ__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 7 Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ------------------------------ 52ms Oct 18 10:23:02 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":203,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1743 Kbps","isStreaming":false,"title":"0.flac?Expires=1729250582&Signature=ka~FVPihgbOb0It6XYJHMyX8K2fGXTQS2HXKl3r~PbD~bu0hZiFaOyhxZ52TDBWOVY~TPcHpMVTNBqYjG1Iga-SiQlMm0KWSBzgxp7TuAEf9zWXvLwIYo9XGZFkbuM5xWNDChNNBlpWWSInlVijcumnRbOa2bOMqayJ9M2pC8unNrXSnYk0gVDoRWxVrPvwXShB8E~rx7BDmo0Nd04KZ4hQ7cc-S~t4HRvShJFompymFytI3cZRHHCGduRRV~L4BiiWk9ana9Deste8WPThZSzJXqPfb7N3edSRIiVzaDNddo5mq-Blx-I033N3BrsyBpr34Sz1S9oRQkP4FKrT6aQ__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEidhOGQ5NzJhMDMzOTU1ZmIxODdjMGMwZTdlNjdhZDEyMl82Mi5tcDQ/0.flac?Expires=1729250582&Signature=ka~FVPihgbOb0It6XYJHMyX8K2fGXTQS2HXKl3r~PbD~bu0hZiFaOyhxZ52TDBWOVY~TPcHpMVTNBqYjG1Iga-SiQlMm0KWSBzgxp7TuAEf9zWXvLwIYo9XGZFkbuM5xWNDChNNBlpWWSInlVijcumnRbOa2bOMqayJ9M2pC8unNrXSnYk0gVDoRWxVrPvwXShB8E~rx7BDmo0Nd04KZ4hQ7cc-S~t4HRvShJFompymFytI3cZRHHCGduRRV~L4BiiWk9ana9Deste8WPThZSzJXqPfb7N3edSRIiVzaDNddo5mq-Blx-I033N3BrsyBpr34Sz1S9oRQkP4FKrT6aQ__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:02 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 7 Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Received an update from plugin. extracting info from payload Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:02 musical-fidelity volumio[1029]: info: ------------------------------ 73ms Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:02 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:02 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:24 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:23:24 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:23:24 musical-fidelity volumio[1029]: info: Discovery: Getting this device information Oct 18 10:23:24 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioGetState Oct 18 10:23:24 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 18 10:23:24 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 18 10:23:24 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioNext Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:29 musical-fidelity volumio[1029]: info: [1729247009229] ControllerTidal::next Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::stop Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:29 musical-fidelity volumio[1029]: verbose: UNSET VOLATILE Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::stPlaybackTimer Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::serviceStop Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 7 Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreCommandRouter::serviceStop Oct 18 10:23:29 musical-fidelity volumio[1029]: info: [1729247009237] ControllerTidal::stop Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:29 musical-fidelity volumio[1029]: info: ControllerMpd::stop Oct 18 10:23:29 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:29 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:29 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 34 milliseconds Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::play index undefined Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::startPlaybackTimer Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:29 musical-fidelity volumio[1029]: info: [1729247009274] ControllerTidal::clearAddPlayTrack Oct 18 10:23:29 musical-fidelity volumio[1029]: info: Getting stream with soundQuality HI_RES Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:29 musical-fidelity volumio[1029]: info: Oct 18 10:23:29 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:29 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:29 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:29 musical-fidelity volumio[1029]: info: sendMpdCommand status took 5 milliseconds Oct 18 10:23:29 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:29 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:29 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 18 10:23:29 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:29 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:29 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:29 musical-fidelity volumio[1029]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Oct 18 10:23:29 musical-fidelity volumio[1029]: info: ------------------------------ 23ms Oct 18 10:23:29 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:30 musical-fidelity volumio[1029]: info: getStreamUrl took 782 milliseconds Oct 18 10:23:30 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:30 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 2 milliseconds Oct 18 10:23:30 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand clear Oct 18 10:23:30 musical-fidelity volumio[1029]: info: Oct 18 10:23:30 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:30 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:30 musical-fidelity volumio[1029]: info: sendMpdCommand clear took 2 milliseconds Oct 18 10:23:30 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczYzkwZDg1YWJmOTg1ZWRmNjQ1MDFiYmIwYjk1ODUxMl82Mi5tcDQ/0.flac?Expires=1729250609&Signature=aji77qOvFC-eox34Hxjvtn7VKr-m0KZY5KMsvVDNce2jVw4BKLyalSwCtDJJehyPE56Y0ChSI1LqIzrlCpNmt8dNGuj3C71a6Lo7Nh4R0zKAnAb8a3EaS7WW7xu4Mdy1Yts2jL5WyF7-zKVFC51uT62EvpGsebybBuUQzB98atYK2MizTCxTiRYz8YisopI8cPGGYhcHZ3~Xr7bkyG83MF9Q~L3syk3DD21VcglDv8ezVQnPxWgAcwSQb40adbq1YB98A3BC9tvKUr8KvWeqfdziP4DEbpSjix4vGfL59jodfARBWtuIAclK2nQsPlLX2Sz5OhAyObvvlDVzl0AUzg__&Key-Pair-Id=K14LZCZ9QUI4JL" Oct 18 10:23:30 musical-fidelity volumio[1029]: error: updateQueue error: null Oct 18 10:23:30 musical-fidelity volumio[1029]: info: Oct 18 10:23:30 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:30 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:30 musical-fidelity volumio[1029]: info: ------------------------------ 5ms Oct 18 10:23:30 musical-fidelity volumio[1029]: info: sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczYzkwZDg1YWJmOTg1ZWRmNjQ1MDFiYmIwYjk1ODUxMl82Mi5tcDQ/0.flac?Expires=1729250609&Signature=aji77qOvFC-eox34Hxjvtn7VKr-m0KZY5KMsvVDNce2jVw4BKLyalSwCtDJJehyPE56Y0ChSI1LqIzrlCpNmt8dNGuj3C71a6Lo7Nh4R0zKAnAb8a3EaS7WW7xu4Mdy1Yts2jL5WyF7-zKVFC51uT62EvpGsebybBuUQzB98atYK2MizTCxTiRYz8YisopI8cPGGYhcHZ3~Xr7bkyG83MF9Q~L3syk3DD21VcglDv8ezVQnPxWgAcwSQb40adbq1YB98A3BC9tvKUr8KvWeqfdziP4DEbpSjix4vGfL59jodfARBWtuIAclK2nQsPlLX2Sz5OhAyObvvlDVzl0AUzg__&Key-Pair-Id=K14LZCZ9QUI4JL" took 3 milliseconds Oct 18 10:23:30 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:30 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand play Oct 18 10:23:30 musical-fidelity volumio[1029]: info: ------------------------------ 5ms Oct 18 10:23:30 musical-fidelity volumio[1029]: info: sendMpdCommand play took 3 milliseconds Oct 18 10:23:30 musical-fidelity volumio[1029]: info: Oct 18 10:23:30 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:30 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:30 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:31 musical-fidelity volumio[1029]: info: sendMpdCommand status took 47 milliseconds Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:31 musical-fidelity volumio[1029]: info: Oct 18 10:23:31 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:31 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:31 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 18 10:23:31 musical-fidelity volumio[1029]: info: sendMpdCommand status took 6 milliseconds Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:31 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?Expires=1729250609&Signature=aji77qOvFC-eox34Hxjvtn7VKr-m0KZY5KMsvVDNce2jVw4BKLyalSwCtDJJehyPE56Y0ChSI1LqIzrlCpNmt8dNGuj3C71a6Lo7Nh4R0zKAnAb8a3EaS7WW7xu4Mdy1Yts2jL5WyF7-zKVFC51uT62EvpGsebybBuUQzB98atYK2MizTCxTiRYz8YisopI8cPGGYhcHZ3~Xr7bkyG83MF9Q~L3syk3DD21VcglDv8ezVQnPxWgAcwSQb40adbq1YB98A3BC9tvKUr8KvWeqfdziP4DEbpSjix4vGfL59jodfARBWtuIAclK2nQsPlLX2Sz5OhAyObvvlDVzl0AUzg__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczYzkwZDg1YWJmOTg1ZWRmNjQ1MDFiYmIwYjk1ODUxMl82Mi5tcDQ/0.flac?Expires=1729250609&Signature=aji77qOvFC-eox34Hxjvtn7VKr-m0KZY5KMsvVDNce2jVw4BKLyalSwCtDJJehyPE56Y0ChSI1LqIzrlCpNmt8dNGuj3C71a6Lo7Nh4R0zKAnAb8a3EaS7WW7xu4Mdy1Yts2jL5WyF7-zKVFC51uT62EvpGsebybBuUQzB98atYK2MizTCxTiRYz8YisopI8cPGGYhcHZ3~Xr7bkyG83MF9Q~L3syk3DD21VcglDv8ezVQnPxWgAcwSQb40adbq1YB98A3BC9tvKUr8KvWeqfdziP4DEbpSjix4vGfL59jodfARBWtuIAclK2nQsPlLX2Sz5OhAyObvvlDVzl0AUzg__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 8 Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:31 musical-fidelity volumio[1029]: info: ------------------------------ 75ms Oct 18 10:23:31 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:31 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":177,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1627 Kbps","isStreaming":false,"title":"0.flac?Expires=1729250609&Signature=aji77qOvFC-eox34Hxjvtn7VKr-m0KZY5KMsvVDNce2jVw4BKLyalSwCtDJJehyPE56Y0ChSI1LqIzrlCpNmt8dNGuj3C71a6Lo7Nh4R0zKAnAb8a3EaS7WW7xu4Mdy1Yts2jL5WyF7-zKVFC51uT62EvpGsebybBuUQzB98atYK2MizTCxTiRYz8YisopI8cPGGYhcHZ3~Xr7bkyG83MF9Q~L3syk3DD21VcglDv8ezVQnPxWgAcwSQb40adbq1YB98A3BC9tvKUr8KvWeqfdziP4DEbpSjix4vGfL59jodfARBWtuIAclK2nQsPlLX2Sz5OhAyObvvlDVzl0AUzg__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczYzkwZDg1YWJmOTg1ZWRmNjQ1MDFiYmIwYjk1ODUxMl82Mi5tcDQ/0.flac?Expires=1729250609&Signature=aji77qOvFC-eox34Hxjvtn7VKr-m0KZY5KMsvVDNce2jVw4BKLyalSwCtDJJehyPE56Y0ChSI1LqIzrlCpNmt8dNGuj3C71a6Lo7Nh4R0zKAnAb8a3EaS7WW7xu4Mdy1Yts2jL5WyF7-zKVFC51uT62EvpGsebybBuUQzB98atYK2MizTCxTiRYz8YisopI8cPGGYhcHZ3~Xr7bkyG83MF9Q~L3syk3DD21VcglDv8ezVQnPxWgAcwSQb40adbq1YB98A3BC9tvKUr8KvWeqfdziP4DEbpSjix4vGfL59jodfARBWtuIAclK2nQsPlLX2Sz5OhAyObvvlDVzl0AUzg__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:31 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 8 Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:23:31 musical-fidelity volumio[1029]: info: Received an update from plugin. extracting info from payload Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:31 musical-fidelity volumio[1029]: info: ------------------------------ 49ms Oct 18 10:23:31 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:31 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:31 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:31 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:31 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:31 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioNext Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:33 musical-fidelity volumio[1029]: info: [1729247013457] ControllerTidal::next Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::stop Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: UNSET VOLATILE Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::stPlaybackTimer Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::serviceStop Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 8 Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreCommandRouter::serviceStop Oct 18 10:23:33 musical-fidelity volumio[1029]: info: [1729247013468] ControllerTidal::stop Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:33 musical-fidelity volumio[1029]: info: ControllerMpd::stop Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:33 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 64 milliseconds Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::play index undefined Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::startPlaybackTimer Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:33 musical-fidelity volumio[1029]: info: [1729247013535] ControllerTidal::clearAddPlayTrack Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Getting stream with soundQuality HI_RES Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Oct 18 10:23:33 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:33 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:33 musical-fidelity volumio[1029]: info: sendMpdCommand status took 5 milliseconds Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:33 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:33 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Oct 18 10:23:33 musical-fidelity volumio[1029]: info: ------------------------------ 23ms Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:33 musical-fidelity volumio[1029]: info: getStreamUrl took 346 milliseconds Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:33 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 2 milliseconds Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand clear Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Oct 18 10:23:33 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:33 musical-fidelity volumio[1029]: info: sendMpdCommand clear took 2 milliseconds Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczMjgxMmI4YzVjYzdiMDY0NjBjZGIxZjcwOGQ4NmM1N182Mi5tcDQ/0.flac?Expires=1729250613&Signature=hSDJNyrQex1NrqCUQkTAlN8eX1TDCDHDrFOhAauiJGFoYUBoYpmibkbxoFFhD0Nk1-H6fU1g7dheAcSrZ0bqyaMM-eMFPkl2-yW0V8pgMnDAYWd42M~MNtOoTzSx3TF1izWLdMojSjyspReNHDVUDHDbAySVT53V~9KiBwWbm05bgZ798A2KnbIvbWiZ-4Pe~HpD2oKABiOeKdeD0qT1ze5J4-6tntqmkCUrTcN~yn90DwOOx0YZfBz2mo6sy8Gy9sdF5wRDdQTsiUpDnBvmiGA4gkPpdbDvp7AuiTZajOztnY91Ato-xMQ2kXgmLT66aE20XsVrL5gCo5ZLE33yVw__&Key-Pair-Id=K14LZCZ9QUI4JL" Oct 18 10:23:33 musical-fidelity volumio[1029]: error: updateQueue error: null Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Oct 18 10:23:33 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:33 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:33 musical-fidelity volumio[1029]: info: ------------------------------ 6ms Oct 18 10:23:33 musical-fidelity volumio[1029]: info: sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczMjgxMmI4YzVjYzdiMDY0NjBjZGIxZjcwOGQ4NmM1N182Mi5tcDQ/0.flac?Expires=1729250613&Signature=hSDJNyrQex1NrqCUQkTAlN8eX1TDCDHDrFOhAauiJGFoYUBoYpmibkbxoFFhD0Nk1-H6fU1g7dheAcSrZ0bqyaMM-eMFPkl2-yW0V8pgMnDAYWd42M~MNtOoTzSx3TF1izWLdMojSjyspReNHDVUDHDbAySVT53V~9KiBwWbm05bgZ798A2KnbIvbWiZ-4Pe~HpD2oKABiOeKdeD0qT1ze5J4-6tntqmkCUrTcN~yn90DwOOx0YZfBz2mo6sy8Gy9sdF5wRDdQTsiUpDnBvmiGA4gkPpdbDvp7AuiTZajOztnY91Ato-xMQ2kXgmLT66aE20XsVrL5gCo5ZLE33yVw__&Key-Pair-Id=K14LZCZ9QUI4JL" took 5 milliseconds Oct 18 10:23:33 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:33 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand play Oct 18 10:23:33 musical-fidelity volumio[1029]: info: ------------------------------ 5ms Oct 18 10:23:33 musical-fidelity volumio[1029]: info: sendMpdCommand play took 3 milliseconds Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Oct 18 10:23:34 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:34 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:34 musical-fidelity volumio[1029]: info: sendMpdCommand status took 7 milliseconds Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Oct 18 10:23:34 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:34 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:34 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:34 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":207,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?Expires=1729250613&Signature=hSDJNyrQex1NrqCUQkTAlN8eX1TDCDHDrFOhAauiJGFoYUBoYpmibkbxoFFhD0Nk1-H6fU1g7dheAcSrZ0bqyaMM-eMFPkl2-yW0V8pgMnDAYWd42M~MNtOoTzSx3TF1izWLdMojSjyspReNHDVUDHDbAySVT53V~9KiBwWbm05bgZ798A2KnbIvbWiZ-4Pe~HpD2oKABiOeKdeD0qT1ze5J4-6tntqmkCUrTcN~yn90DwOOx0YZfBz2mo6sy8Gy9sdF5wRDdQTsiUpDnBvmiGA4gkPpdbDvp7AuiTZajOztnY91Ato-xMQ2kXgmLT66aE20XsVrL5gCo5ZLE33yVw__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczMjgxMmI4YzVjYzdiMDY0NjBjZGIxZjcwOGQ4NmM1N182Mi5tcDQ/0.flac?Expires=1729250613&Signature=hSDJNyrQex1NrqCUQkTAlN8eX1TDCDHDrFOhAauiJGFoYUBoYpmibkbxoFFhD0Nk1-H6fU1g7dheAcSrZ0bqyaMM-eMFPkl2-yW0V8pgMnDAYWd42M~MNtOoTzSx3TF1izWLdMojSjyspReNHDVUDHDbAySVT53V~9KiBwWbm05bgZ798A2KnbIvbWiZ-4Pe~HpD2oKABiOeKdeD0qT1ze5J4-6tntqmkCUrTcN~yn90DwOOx0YZfBz2mo6sy8Gy9sdF5wRDdQTsiUpDnBvmiGA4gkPpdbDvp7AuiTZajOztnY91Ato-xMQ2kXgmLT66aE20XsVrL5gCo5ZLE33yVw__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 9 Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:34 musical-fidelity volumio[1029]: info: ------------------------------ 36ms Oct 18 10:23:34 musical-fidelity volumio[1029]: info: sendMpdCommand status took 25 milliseconds Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:34 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 25 milliseconds Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:34 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":207,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1399 Kbps","isStreaming":false,"title":"0.flac?Expires=1729250613&Signature=hSDJNyrQex1NrqCUQkTAlN8eX1TDCDHDrFOhAauiJGFoYUBoYpmibkbxoFFhD0Nk1-H6fU1g7dheAcSrZ0bqyaMM-eMFPkl2-yW0V8pgMnDAYWd42M~MNtOoTzSx3TF1izWLdMojSjyspReNHDVUDHDbAySVT53V~9KiBwWbm05bgZ798A2KnbIvbWiZ-4Pe~HpD2oKABiOeKdeD0qT1ze5J4-6tntqmkCUrTcN~yn90DwOOx0YZfBz2mo6sy8Gy9sdF5wRDdQTsiUpDnBvmiGA4gkPpdbDvp7AuiTZajOztnY91Ato-xMQ2kXgmLT66aE20XsVrL5gCo5ZLE33yVw__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEiczMjgxMmI4YzVjYzdiMDY0NjBjZGIxZjcwOGQ4NmM1N182Mi5tcDQ/0.flac?Expires=1729250613&Signature=hSDJNyrQex1NrqCUQkTAlN8eX1TDCDHDrFOhAauiJGFoYUBoYpmibkbxoFFhD0Nk1-H6fU1g7dheAcSrZ0bqyaMM-eMFPkl2-yW0V8pgMnDAYWd42M~MNtOoTzSx3TF1izWLdMojSjyspReNHDVUDHDbAySVT53V~9KiBwWbm05bgZ798A2KnbIvbWiZ-4Pe~HpD2oKABiOeKdeD0qT1ze5J4-6tntqmkCUrTcN~yn90DwOOx0YZfBz2mo6sy8Gy9sdF5wRDdQTsiUpDnBvmiGA4gkPpdbDvp7AuiTZajOztnY91Ato-xMQ2kXgmLT66aE20XsVrL5gCo5ZLE33yVw__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:34 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 9 Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Received an update from plugin. extracting info from payload Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:34 musical-fidelity volumio[1029]: info: ------------------------------ 103ms Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:34 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:34 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioNext Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:41 musical-fidelity volumio[1029]: info: [1729247021770] ControllerTidal::next Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::stop Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:41 musical-fidelity volumio[1029]: verbose: UNSET VOLATILE Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::stPlaybackTimer Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::serviceStop Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 9 Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreCommandRouter::serviceStop Oct 18 10:23:41 musical-fidelity volumio[1029]: info: [1729247021777] ControllerTidal::stop Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:41 musical-fidelity volumio[1029]: info: ControllerMpd::stop Oct 18 10:23:41 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:41 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:41 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 82 milliseconds Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::play index undefined Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::startPlaybackTimer Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:41 musical-fidelity volumio[1029]: info: [1729247021863] ControllerTidal::clearAddPlayTrack Oct 18 10:23:41 musical-fidelity volumio[1029]: info: Getting stream with soundQuality HI_RES Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:41 musical-fidelity volumio[1029]: info: Oct 18 10:23:41 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:41 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:41 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:41 musical-fidelity volumio[1029]: info: sendMpdCommand status took 5 milliseconds Oct 18 10:23:41 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:41 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:41 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 18 10:23:41 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:41 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:41 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:41 musical-fidelity volumio[1029]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Oct 18 10:23:41 musical-fidelity volumio[1029]: info: ------------------------------ 28ms Oct 18 10:23:41 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:42 musical-fidelity volumio[1029]: info: getStreamUrl took 696 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 1 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand clear Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Oct 18 10:23:42 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand clear took 2 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic0YjZhZjkxMjUwMzQwOTk5MjY4NjYyNWM4M2U5YjlmZl82MS5tcDQ/0.flac?Expires=1729250622&Signature=g8gdENP9oLWAH02qsmvwlRRPQJkxw~Axll2y7lcoHPY3M27fr00cAjuqPkJYBUZhaklmr-F9oE6WfjB0QSXY~gw9M67ADZ768UsYeo1ottfs9TvXaiNQRUvau0XaZLz6brSkIDixtja36XBKqZhFBwbdl47qpYLijiyDkZbly8LfBOm9dpulXAzvh8Mo3LPzLGbWBvCnsPoVzK2H~c0EVrSvClgqKhNMG9GLmI7bVkb2KPK2wjdAl7jAV5--Qu-hYhPXo3TakKLq~XtU7Xm~3Dr2dqe8DUCoqMDOGhUHDD9zJXl6AW0LIAhLx68XJ0KFU~QUPT9lys5I13zrcW2GxA__&Key-Pair-Id=K14LZCZ9QUI4JL" Oct 18 10:23:42 musical-fidelity volumio[1029]: error: updateQueue error: null Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Oct 18 10:23:42 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ------------------------------ 4ms Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic0YjZhZjkxMjUwMzQwOTk5MjY4NjYyNWM4M2U5YjlmZl82MS5tcDQ/0.flac?Expires=1729250622&Signature=g8gdENP9oLWAH02qsmvwlRRPQJkxw~Axll2y7lcoHPY3M27fr00cAjuqPkJYBUZhaklmr-F9oE6WfjB0QSXY~gw9M67ADZ768UsYeo1ottfs9TvXaiNQRUvau0XaZLz6brSkIDixtja36XBKqZhFBwbdl47qpYLijiyDkZbly8LfBOm9dpulXAzvh8Mo3LPzLGbWBvCnsPoVzK2H~c0EVrSvClgqKhNMG9GLmI7bVkb2KPK2wjdAl7jAV5--Qu-hYhPXo3TakKLq~XtU7Xm~3Dr2dqe8DUCoqMDOGhUHDD9zJXl6AW0LIAhLx68XJ0KFU~QUPT9lys5I13zrcW2GxA__&Key-Pair-Id=K14LZCZ9QUI4JL" took 3 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand play Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ------------------------------ 5ms Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand play took 2 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Oct 18 10:23:42 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Oct 18 10:23:42 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand status took 54 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"273 Kbps","isStreaming":false,"title":"0.flac?Expires=1729250622&Signature=g8gdENP9oLWAH02qsmvwlRRPQJkxw~Axll2y7lcoHPY3M27fr00cAjuqPkJYBUZhaklmr-F9oE6WfjB0QSXY~gw9M67ADZ768UsYeo1ottfs9TvXaiNQRUvau0XaZLz6brSkIDixtja36XBKqZhFBwbdl47qpYLijiyDkZbly8LfBOm9dpulXAzvh8Mo3LPzLGbWBvCnsPoVzK2H~c0EVrSvClgqKhNMG9GLmI7bVkb2KPK2wjdAl7jAV5--Qu-hYhPXo3TakKLq~XtU7Xm~3Dr2dqe8DUCoqMDOGhUHDD9zJXl6AW0LIAhLx68XJ0KFU~QUPT9lys5I13zrcW2GxA__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic0YjZhZjkxMjUwMzQwOTk5MjY4NjYyNWM4M2U5YjlmZl82MS5tcDQ/0.flac?Expires=1729250622&Signature=g8gdENP9oLWAH02qsmvwlRRPQJkxw~Axll2y7lcoHPY3M27fr00cAjuqPkJYBUZhaklmr-F9oE6WfjB0QSXY~gw9M67ADZ768UsYeo1ottfs9TvXaiNQRUvau0XaZLz6brSkIDixtja36XBKqZhFBwbdl47qpYLijiyDkZbly8LfBOm9dpulXAzvh8Mo3LPzLGbWBvCnsPoVzK2H~c0EVrSvClgqKhNMG9GLmI7bVkb2KPK2wjdAl7jAV5--Qu-hYhPXo3TakKLq~XtU7Xm~3Dr2dqe8DUCoqMDOGhUHDD9zJXl6AW0LIAhLx68XJ0KFU~QUPT9lys5I13zrcW2GxA__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 10 Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ------------------------------ 86ms Oct 18 10:23:42 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 26 milliseconds Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"0.flac?Expires=1729250622&Signature=g8gdENP9oLWAH02qsmvwlRRPQJkxw~Axll2y7lcoHPY3M27fr00cAjuqPkJYBUZhaklmr-F9oE6WfjB0QSXY~gw9M67ADZ768UsYeo1ottfs9TvXaiNQRUvau0XaZLz6brSkIDixtja36XBKqZhFBwbdl47qpYLijiyDkZbly8LfBOm9dpulXAzvh8Mo3LPzLGbWBvCnsPoVzK2H~c0EVrSvClgqKhNMG9GLmI7bVkb2KPK2wjdAl7jAV5--Qu-hYhPXo3TakKLq~XtU7Xm~3Dr2dqe8DUCoqMDOGhUHDD9zJXl6AW0LIAhLx68XJ0KFU~QUPT9lys5I13zrcW2GxA__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic0YjZhZjkxMjUwMzQwOTk5MjY4NjYyNWM4M2U5YjlmZl82MS5tcDQ/0.flac?Expires=1729250622&Signature=g8gdENP9oLWAH02qsmvwlRRPQJkxw~Axll2y7lcoHPY3M27fr00cAjuqPkJYBUZhaklmr-F9oE6WfjB0QSXY~gw9M67ADZ768UsYeo1ottfs9TvXaiNQRUvau0XaZLz6brSkIDixtja36XBKqZhFBwbdl47qpYLijiyDkZbly8LfBOm9dpulXAzvh8Mo3LPzLGbWBvCnsPoVzK2H~c0EVrSvClgqKhNMG9GLmI7bVkb2KPK2wjdAl7jAV5--Qu-hYhPXo3TakKLq~XtU7Xm~3Dr2dqe8DUCoqMDOGhUHDD9zJXl6AW0LIAhLx68XJ0KFU~QUPT9lys5I13zrcW2GxA__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:42 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 10 Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Received an update from plugin. extracting info from payload Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:42 musical-fidelity volumio[1029]: info: ------------------------------ 69ms Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:42 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:42 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioNext Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:45 musical-fidelity volumio[1029]: info: [1729247025250] ControllerTidal::next Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::next Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::stop Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: UNSET VOLATILE Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::stPlaybackTimer Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::serviceStop Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 10 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::serviceStop Oct 18 10:23:45 musical-fidelity volumio[1029]: info: [1729247025270] ControllerTidal::stop Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ControllerMpd::stop Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Oct 18 10:23:45 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 82 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::play index undefined Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::startPlaybackTimer Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: [1729247025355] ControllerTidal::clearAddPlayTrack Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Getting stream with soundQuality HI_RES Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::updateTrackBlock Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrackBlock Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand status took 14 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ------------------------------ 36ms Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:45 musical-fidelity volumio[1029]: info: getStreamUrl took 354 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand stop took 2 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand clear Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Oct 18 10:23:45 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand clear took 3 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic3MTNlMWNhYTZkM2NjNDM4ZDFkYzc2YjI0NDMxYjFhOF82Mi5tcDQ/0.flac?Expires=1729250625&Signature=GCYUI9w8Z4niS1PUIrTXy-9VK0aRfJu3~~CJ02prMb0TFWEHGNCkiOJ7gRTFtak0a2VmsRLrn~jT~TAPwH532XQVJW117fW4HvqzqRk8e7h2BhJUWoHvfU~duLtcE1jnQysX~F2prsSo-kwgjmX0q41xY30oWNCYQwPIrYFGfvLysukMUuv9z516Lm6-QQNY8bdMTvXTGOmheC~buJm-KNbv1xZMjDQaoELrr6DEgjhtLW6rbVsHEzQpK03hM7tHu2OwMbO2JWYvzhWTxaymDBEOlKJExab9Ai2pIcK9FKkFfnfOsi7BkDoDyxvY3EHZmCEI7wAuLtOYdDuvu6i4Eg__&Key-Pair-Id=K14LZCZ9QUI4JL" Oct 18 10:23:45 musical-fidelity volumio[1029]: error: updateQueue error: null Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Oct 18 10:23:45 musical-fidelity volumio[1029]: ---------------------------- MPD announces system playlist update Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Ignoring MPD Status Update Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ------------------------------ 4ms Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic3MTNlMWNhYTZkM2NjNDM4ZDFkYzc2YjI0NDMxYjFhOF82Mi5tcDQ/0.flac?Expires=1729250625&Signature=GCYUI9w8Z4niS1PUIrTXy-9VK0aRfJu3~~CJ02prMb0TFWEHGNCkiOJ7gRTFtak0a2VmsRLrn~jT~TAPwH532XQVJW117fW4HvqzqRk8e7h2BhJUWoHvfU~duLtcE1jnQysX~F2prsSo-kwgjmX0q41xY30oWNCYQwPIrYFGfvLysukMUuv9z516Lm6-QQNY8bdMTvXTGOmheC~buJm-KNbv1xZMjDQaoELrr6DEgjhtLW6rbVsHEzQpK03hM7tHu2OwMbO2JWYvzhWTxaymDBEOlKJExab9Ai2pIcK9FKkFfnfOsi7BkDoDyxvY3EHZmCEI7wAuLtOYdDuvu6i4Eg__&Key-Pair-Id=K14LZCZ9QUI4JL" took 3 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand play Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ------------------------------ 5ms Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand play took 4 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Oct 18 10:23:45 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Oct 18 10:23:45 musical-fidelity volumio[1029]: ---------------------------- MPD announces state update: player Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand status took 54 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ControllerMpd::getState Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand status took 12 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseState Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?Expires=1729250625&Signature=GCYUI9w8Z4niS1PUIrTXy-9VK0aRfJu3~~CJ02prMb0TFWEHGNCkiOJ7gRTFtak0a2VmsRLrn~jT~TAPwH532XQVJW117fW4HvqzqRk8e7h2BhJUWoHvfU~duLtcE1jnQysX~F2prsSo-kwgjmX0q41xY30oWNCYQwPIrYFGfvLysukMUuv9z516Lm6-QQNY8bdMTvXTGOmheC~buJm-KNbv1xZMjDQaoELrr6DEgjhtLW6rbVsHEzQpK03hM7tHu2OwMbO2JWYvzhWTxaymDBEOlKJExab9Ai2pIcK9FKkFfnfOsi7BkDoDyxvY3EHZmCEI7wAuLtOYdDuvu6i4Eg__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic3MTNlMWNhYTZkM2NjNDM4ZDFkYzc2YjI0NDMxYjFhOF82Mi5tcDQ/0.flac?Expires=1729250625&Signature=GCYUI9w8Z4niS1PUIrTXy-9VK0aRfJu3~~CJ02prMb0TFWEHGNCkiOJ7gRTFtak0a2VmsRLrn~jT~TAPwH532XQVJW117fW4HvqzqRk8e7h2BhJUWoHvfU~duLtcE1jnQysX~F2prsSo-kwgjmX0q41xY30oWNCYQwPIrYFGfvLysukMUuv9z516Lm6-QQNY8bdMTvXTGOmheC~buJm-KNbv1xZMjDQaoELrr6DEgjhtLW6rbVsHEzQpK03hM7tHu2OwMbO2JWYvzhWTxaymDBEOlKJExab9Ai2pIcK9FKkFfnfOsi7BkDoDyxvY3EHZmCEI7wAuLtOYdDuvu6i4Eg__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus stop Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ------------------------------ 127ms Oct 18 10:23:45 musical-fidelity volumio[1029]: info: sendMpdCommand playlistinfo took 41 milliseconds Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ControllerMpd::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":230,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1366 Kbps","isStreaming":false,"title":"0.flac?Expires=1729250625&Signature=GCYUI9w8Z4niS1PUIrTXy-9VK0aRfJu3~~CJ02prMb0TFWEHGNCkiOJ7gRTFtak0a2VmsRLrn~jT~TAPwH532XQVJW117fW4HvqzqRk8e7h2BhJUWoHvfU~duLtcE1jnQysX~F2prsSo-kwgjmX0q41xY30oWNCYQwPIrYFGfvLysukMUuv9z516Lm6-QQNY8bdMTvXTGOmheC~buJm-KNbv1xZMjDQaoELrr6DEgjhtLW6rbVsHEzQpK03hM7tHu2OwMbO2JWYvzhWTxaymDBEOlKJExab9Ai2pIcK9FKkFfnfOsi7BkDoDyxvY3EHZmCEI7wAuLtOYdDuvu6i4Eg__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKwgDEic3MTNlMWNhYTZkM2NjNDM4ZDFkYzc2YjI0NDMxYjFhOF82Mi5tcDQ/0.flac?Expires=1729250625&Signature=GCYUI9w8Z4niS1PUIrTXy-9VK0aRfJu3~~CJ02prMb0TFWEHGNCkiOJ7gRTFtak0a2VmsRLrn~jT~TAPwH532XQVJW117fW4HvqzqRk8e7h2BhJUWoHvfU~duLtcE1jnQysX~F2prsSo-kwgjmX0q41xY30oWNCYQwPIrYFGfvLysukMUuv9z516Lm6-QQNY8bdMTvXTGOmheC~buJm-KNbv1xZMjDQaoELrr6DEgjhtLW6rbVsHEzQpK03hM7tHu2OwMbO2JWYvzhWTxaymDBEOlKJExab9Ai2pIcK9FKkFfnfOsi7BkDoDyxvY3EHZmCEI7wAuLtOYdDuvu6i4Eg__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Oct 18 10:23:45 musical-fidelity volumio[1029]: verbose: CURRENT POSITION 11 Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState stateService play Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:23:45 musical-fidelity volumio[1029]: info: Received an update from plugin. extracting info from payload Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreStateMachine::pushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPushState Oct 18 10:23:45 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:23:45 musical-fidelity volumio[1029]: info: ------------------------------ 149ms Oct 18 10:23:46 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:46 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:46 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:46 musical-fidelity volumio[1029]: info: Updating push state because input changed Oct 18 10:23:46 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumiosetSourceActivempd Oct 18 10:23:46 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:23:46 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:46 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:46 musical-fidelity volumio[1029]: info: Updating RAAT Signal Path Oct 18 10:23:54 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:23:54 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:23:54 musical-fidelity volumio[1029]: info: Discovery: Getting this device information Oct 18 10:23:54 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioGetState Oct 18 10:23:54 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 18 10:23:54 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 18 10:23:54 musical-fidelity volumio[1029]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 18 10:24:06 musical-fidelity volumio[1029]: info: CoreCommandRouter::volumioPause Oct 18 10:24:06 musical-fidelity volumio[1029]: info: CoreStateMachine::pause Oct 18 10:24:06 musical-fidelity volumio[1029]: info: CoreStateMachine::stPlaybackTimer Oct 18 10:24:06 musical-fidelity volumio[1029]: info: CoreStateMachine::servicePause Oct 18 10:24:06 musical-fidelity volumio[1029]: info: CorePlayQueue::getTrack 11 Oct 18 10:24:06 musical-fidelity volumio[1029]: info: CoreCommandRouter::servicePause Oct 18 10:24:06 musical-fidelity volumio[1029]: info: [1729247046266] ControllerTidal::pause Oct 18 10:24:06 musical-fidelity volumio[1029]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:24:06 musical-fidelity volumio[1029]: info: ControllerMpd::pause Oct 18 10:24:06 musical-fidelity volumio[1029]: verbose: ControllerMpd::sendMpdCommand pause Oct 18 10:24:06 musical-fidelity systemd-journal[10990]: Runtime journal is using 8.0M (max allowed 30.0M, trying to leave 70.4M free of 460.9M available → current limit 30.0M). Oct 18 10:24:06 musical-fidelity kernel: Unable to handle kernel NULL pointer dereference at virtual address 00000023 Oct 18 10:24:06 musical-fidelity kernel: pgd = aed14000 Oct 18 10:24:06 musical-fidelity kernel: [00000023] *pgd=00000000 Oct 18 10:24:06 musical-fidelity kernel: Internal error: Oops: 5 [#1] SMP ARM Oct 18 10:24:06 musical-fidelity kernel: Modules linked in: bnep xt_REDIRECT nf_nat_redirect xt_tcpudp iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack ip_tables x_tables nfsd 8723bu(O) snd_usb_audio btusb(O) btrtl(O) btintel(O) btbcm(O) cfg80211 bluetooth snd_hwdep snd_usbmidi_lib snd_seq_midi snd_seq_midi_event snd_rawmidi rfkill snd_pcm snd_seq snd_seq_device snd_timer joydev evdev snd bcm2835_gpiomem fixed uio_pdrv_genirq uio i2c_dev ipv6 fuse squashfs overlay Oct 18 10:24:06 musical-fidelity kernel: CPU: 3 PID: 200 Comm: systemd-journal Tainted: G O 4.9.65-v7+ #1 Oct 18 10:24:06 musical-fidelity kernel: Hardware name: BCM2835 Oct 18 10:24:06 musical-fidelity kernel: task: aeca8ec0 task.stack: aedfe000 Oct 18 10:24:06 musical-fidelity kernel: PC is at skb_release_data+0x64/0x128 Oct 18 10:24:06 musical-fidelity kernel: LR is at skb_release_all+0x30/0x34 Oct 18 10:24:06 musical-fidelity kernel: pc : [<805fff80>] lr : [<80600074>] psr: 60000013 sp : aedffd78 ip : aedffd98 fp : aedffd94 Oct 18 10:24:06 musical-fidelity kernel: r10: ae9f8900 r9 : 00000000 r8 : 00000000 Oct 18 10:24:06 musical-fidelity kernel: r7 : 00000023 r6 : b44d8a80 r5 : b44d8a80 r4 : b44d8a80 Oct 18 10:24:06 musical-fidelity kernel: r3 : 00000000 r2 : 00000001 r1 : 00000000 r0 : b44d8a80 Oct 18 10:24:06 musical-fidelity kernel: Flags: nZCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user Oct 18 10:24:06 musical-fidelity kernel: Control: 10c5383d Table: 2ed1406a DAC: 00000055 Oct 18 10:24:06 musical-fidelity kernel: Process systemd-journal (pid: 200, stack limit = 0xaedfe210) Oct 18 10:24:06 musical-fidelity kernel: Stack: (0xaedffd78 to 0xaee00000) Oct 18 10:24:06 musical-fidelity kernel: fd60: b44d8a80 b44d8a80 Oct 18 10:24:06 musical-fidelity kernel: fd80: aedffe5c 000007b9 aedffdac aedffd98 80600074 805fff28 00000001 b44d8a80 Oct 18 10:24:06 musical-fidelity kernel: fda0: aedffdc4 aedffdb0 806001f8 80600050 b44d8a80 00000047 aedffe54 aedffdc8 Oct 18 10:24:06 musical-fidelity kernel: fdc0: 806c2264 806001cc aedffe3c aedffdd8 ae9f8a44 00000001 00000000 00000001 Oct 18 10:24:06 musical-fidelity kernel: fde0: ae9f8b0c 00000000 ae9f8b4c b49bbc00 00000047 00000001 00000047 ae9f8984 Oct 18 10:24:06 musical-fidelity kernel: fe00: aea19240 00000000 00000405 000003e8 000003e8 aedfe000 00000000 00000000 Oct 18 10:24:06 musical-fidelity kernel: fe20: 00000000 00000000 00000000 00000000 aedfff00 aedffee8 aedfff78 00000800 Oct 18 10:24:06 musical-fidelity kernel: fe40: 00d74371 00000000 aedffe84 aedffe58 806c2410 806c1b10 806bdb84 806be394 Oct 18 10:24:06 musical-fidelity kernel: fe60: b49bbc00 aedffe88 00000000 00000800 00000040 00000000 aedffed4 aedffe88 Oct 18 10:24:06 musical-fidelity kernel: fe80: 805f71e0 806c23d4 00000000 00000000 00000000 00000047 000007b9 aedffee0 Oct 18 10:24:06 musical-fidelity kernel: fea0: 00000001 805c88c0 00000000 00000000 00000040 aedfff00 aeaacd2c 00000000 Oct 18 10:24:06 musical-fidelity kernel: fec0: 00000000 aef29540 aedfff44 aedffed8 80268b64 805f7150 00000800 0000001e Oct 18 10:24:06 musical-fidelity kernel: fee0: 00d74371 00000800 00000000 00000000 00000800 aedffee0 00000001 805c88c0 Oct 18 10:24:06 musical-fidelity kernel: ff00: aef29540 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Oct 18 10:24:06 musical-fidelity kernel: ff20: 8017ea84 00000800 aef29540 00d74371 aedfff78 00000800 aedfff74 aedfff48 Oct 18 10:24:06 musical-fidelity kernel: ff40: 8026996c 80268aa0 00000159 80289034 aedfff74 00000000 00000000 aef29540 Oct 18 10:24:06 musical-fidelity kernel: ff60: aef29540 00000800 aedfffa4 aedfff78 8026ab28 802698e0 00000000 00000000 Oct 18 10:24:06 musical-fidelity kernel: ff80: 00d74348 76ff7f10 7ef5b728 00000003 80107fa4 aedfe000 00000000 aedfffa8 Oct 18 10:24:06 musical-fidelity kernel: ffa0: 80107e20 8026aae8 00d74348 76ff7f10 00000014 00d74371 00000800 00000011 Oct 18 10:24:06 musical-fidelity kernel: ffc0: 00d74348 76ff7f10 7ef5b728 00000003 76ff7f10 00d6b0a0 00d6b088 7ef5ba1c Oct 18 10:24:06 musical-fidelity kernel: ffe0: 00000000 7ef5b704 00421e78 76faec8c 60000010 00000014 3b7fa861 3b7fac61 Oct 18 10:24:06 musical-fidelity kernel: [<805fff80>] (skb_release_data) from [<80600074>] (skb_release_all+0x30/0x34) Oct 18 10:24:06 musical-fidelity kernel: [<80600074>] (skb_release_all) from [<806001f8>] (consume_skb+0x38/0xe4) Oct 18 10:24:06 musical-fidelity kernel: [<806001f8>] (consume_skb) from [<806c2264>] (unix_stream_read_generic+0x760/0x834) Oct 18 10:24:06 musical-fidelity kernel: [<806c2264>] (unix_stream_read_generic) from [<806c2410>] (unix_stream_recvmsg+0x48/0x54) Oct 18 10:24:06 musical-fidelity kernel: [<806c2410>] (unix_stream_recvmsg) from [<805f71e0>] (sock_read_iter+0x9c/0xd0) Oct 18 10:24:06 musical-fidelity kernel: [<805f71e0>] (sock_read_iter) from [<80268b64>] (__vfs_read+0xd0/0x120) Oct 18 10:24:06 musical-fidelity kernel: [<80268b64>] (__vfs_read) from [<8026996c>] (vfs_read+0x98/0x16c) Oct 18 10:24:06 musical-fidelity kernel: [<8026996c>] (vfs_read) from [<8026ab28>] (SyS_read+0x4c/0xa0) Oct 18 10:24:06 musical-fidelity kernel: [<8026ab28>] (SyS_read) from [<80107e20>] (ret_fast_syscall+0x0/0x1c) Oct 18 10:24:06 musical-fidelity kernel: Code: 1afffffa f57ff05b e3510000 189da8f0 (e5d73000) Oct 18 10:24:06 musical-fidelity kernel: ---[ end trace c2aa74cef48e7a49 ]--- Oct 18 10:24:06 musical-fidelity systemd[1]: systemd-journald.service has no holdoff time, scheduling restart. Oct 18 10:24:06 musical-fidelity systemd[1]: Stopping Journal Service... Oct 18 10:24:06 musical-fidelity systemd[1]: Starting Journal Service... Oct 18 10:24:06 musical-fidelity systemd[1]: Started Journal Service. Oct 18 10:24:06 musical-fidelity systemd-journal[10990]: Journal started Oct 18 10:24:06 musical-fidelity systemd[1]: systemd-journald.service: main process exited, code=killed, status=11/SEGV Oct 18 10:24:06 musical-fidelity systemd[1]: Unit systemd-journald.service entered failed state. Oct 18 10:24:06 musical-fidelity systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Oct 18 10:24:06 musical-fidelity systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Oct 18 10:24:07 musical-fidelity sudo[11002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-18 10:23 Oct 18 10:24:07 musical-fidelity sudo[11002]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"