-- Logs begin at Wed 2022-07-13 14:55:24 UTC, end at Tue 2025-02-25 19:46:24 UTC. -- Feb 25 19:45:06 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Feb 25 19:45:06 musical-fidelity volumio[1052]: info: browseTIDALUri took 412 milliseconds Feb 25 19:45:07 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: Executing endpoint metavolumio Feb 25 19:45:08 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 19:45:10 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:45:10 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:45:10 musical-fidelity volumio[1052]: info: Discovery: Getting this device information Feb 25 19:45:10 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioGetState Feb 25 19:45:10 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Feb 25 19:45:10 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:10 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::ClearQueue Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::stop Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::stPlaybackTimer Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::updateTrackBlock Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrackBlock Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::serviceStop Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::serviceStop Feb 25 19:45:11 musical-fidelity volumio[1052]: info: [1740512711725] ControllerTidal::stop Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 19:45:11 musical-fidelity volumio[1052]: info: ControllerMpd::stop Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CorePlayQueue::clearPlayQueue Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CorePlayQueue::saveQueue Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushQueue Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::addQueueItems Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CorePlayQueue::addQueueItems Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766600 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766600 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766601 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766601 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766602 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766602 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766603 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766603 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766604 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766604 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766605 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766605 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766606 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766606 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766607 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766607 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766608 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766608 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766609 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766609 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766610 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766610 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766611 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766611 in service tidal Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Updating push state because input changed Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumiosetSourceActivempd Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:11 musical-fidelity volumio[1052]: info: Feb 25 19:45:11 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:45:11 musical-fidelity volumio[1052]: info: sendMpdCommand stop took 96 milliseconds Feb 25 19:45:11 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:45:11 musical-fidelity volumio[1052]: info: sendMpdCommand status took 4 milliseconds Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:45:11 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:45:11 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?Expires=1740516292&Signature=SDRdqqx-46iWJLsxo-jgrI6qvVsBt4H7zZDXS5Xib4ZKbuYp8XIHvJCcacfIM-NnkYLsUA0-pDPkWbTzt20T2ADBF9HNHPvmXzuFvkPcPKtAS5piBquOzzC7u7kV17Y7V0FO~wu85uf8d2~gv-GvTcCGAifXfI5YXXfwFo4jOac1PtL92XwI7j4NwxS9N9f8K4ikYjdwrXlQl-eXHCmQZZyfSmA3eG5Aa9Ng08p0lJvh8rp0e7QqegJJQy9pipLw8bKglSOK8l9fw6Uw9Up~iXd5nCZ5qaXSIMCmnVu7HcOJu7bxsICYZQG2oZBiLbZK33KA5~pKmqkkfo0yKxQLeQ__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKAgDEiRjZTk3ZjUwYzQyMTA3ZGFjYjNjYjI1YjhjMDJiOTYzZS5tcDQ/0.flac?Expires=1740516292&Signature=SDRdqqx-46iWJLsxo-jgrI6qvVsBt4H7zZDXS5Xib4ZKbuYp8XIHvJCcacfIM-NnkYLsUA0-pDPkWbTzt20T2ADBF9HNHPvmXzuFvkPcPKtAS5piBquOzzC7u7kV17Y7V0FO~wu85uf8d2~gv-GvTcCGAifXfI5YXXfwFo4jOac1PtL92XwI7j4NwxS9N9f8K4ikYjdwrXlQl-eXHCmQZZyfSmA3eG5Aa9Ng08p0lJvh8rp0e7QqegJJQy9pipLw8bKglSOK8l9fw6Uw9Up~iXd5nCZ5qaXSIMCmnVu7HcOJu7bxsICYZQG2oZBiLbZK33KA5~pKmqkkfo0yKxQLeQ__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:45:11 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 0 Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService stop Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:11 musical-fidelity volumio[1052]: info: No code Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:11 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:11 musical-fidelity volumio[1052]: info: ------------------------------ 46ms Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 478 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 482 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 481 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 482 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 495 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 494 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 502 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 496 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 502 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 539 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 536 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: explodeTIDALUri took 538 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CorePlayQueue::saveQueue Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushQueue Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::updateTrackBlock Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrackBlock Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPlay Feb 25 19:45:12 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::play index 0 Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::stop Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:45:12 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::play index undefined Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::startPlaybackTimer Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:45:12 musical-fidelity volumio[1052]: info: [1740512712294] ControllerTidal::clearAddPlayTrack Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Getting stream with soundQuality LOW Feb 25 19:45:12 musical-fidelity volumio[1052]: info: getStreamUrl took 280 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 19:45:12 musical-fidelity volumio[1052]: info: sendMpdCommand stop took 2 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Feb 25 19:45:12 musical-fidelity volumio[1052]: ---------------------------- MPD announces system playlist update Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Ignoring MPD Status Update Feb 25 19:45:12 musical-fidelity volumio[1052]: info: sendMpdCommand clear took 2 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "http://amz-pr-cf.audio.tidal.com/4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL" Feb 25 19:45:12 musical-fidelity volumio[1052]: error: updateQueue error: null Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Feb 25 19:45:12 musical-fidelity volumio[1052]: ---------------------------- MPD announces system playlist update Feb 25 19:45:12 musical-fidelity volumio[1052]: info: Ignoring MPD Status Update Feb 25 19:45:12 musical-fidelity volumio[1052]: info: ------------------------------ 3ms Feb 25 19:45:12 musical-fidelity volumio[1052]: info: sendMpdCommand add "http://amz-pr-cf.audio.tidal.com/4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL" took 3 milliseconds Feb 25 19:45:12 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 19:45:12 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand play Feb 25 19:45:12 musical-fidelity volumio[1052]: info: ------------------------------ 4ms Feb 25 19:45:12 musical-fidelity volumio[1052]: info: sendMpdCommand play took 3 milliseconds Feb 25 19:45:13 musical-fidelity volumio[1052]: info: Feb 25 19:45:13 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:45:13 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:45:13 musical-fidelity volumio[1052]: info: Feb 25 19:45:13 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:45:13 musical-fidelity volumio[1052]: info: sendMpdCommand status took 2 milliseconds Feb 25 19:45:13 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:45:13 musical-fidelity volumio[1052]: info: sendMpdCommand status took 2 milliseconds Feb 25 19:45:13 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:45:13 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":349,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 0 Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService play Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:13 musical-fidelity volumio[1052]: info: ------------------------------ 23ms Feb 25 19:45:13 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:45:13 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":289,"duration":349,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:45:13 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 0 Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService play Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus play Feb 25 19:45:13 musical-fidelity volumio[1052]: info: Received an update from plugin. extracting info from payload Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:45:13 musical-fidelity volumio[1052]: info: ------------------------------ 47ms Feb 25 19:45:13 musical-fidelity volumio[1052]: info: Updating push state because input changed Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumiosetSourceActivempd Feb 25 19:45:13 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 19:45:13 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:13 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:13 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:45:22 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:45:22 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:45:22 musical-fidelity volumio[1052]: info: Discovery: Getting this device information Feb 25 19:45:22 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioGetState Feb 25 19:45:22 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Feb 25 19:45:22 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:22 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:34 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:45:34 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:45:34 musical-fidelity volumio[1052]: info: Discovery: Getting this device information Feb 25 19:45:34 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioGetState Feb 25 19:45:34 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Feb 25 19:45:34 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:34 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:45 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:45:45 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:45:45 musical-fidelity volumio[1052]: info: Discovery: Getting this device information Feb 25 19:45:45 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioGetState Feb 25 19:45:45 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Feb 25 19:45:45 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:45 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:57 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:45:57 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:45:57 musical-fidelity volumio[1052]: info: Discovery: Getting this device information Feb 25 19:45:57 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioGetState Feb 25 19:45:57 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Feb 25 19:45:57 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:45:57 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:46:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:46:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:46:07 musical-fidelity volumio[1052]: info: Discovery: Getting this device information Feb 25 19:46:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioGetState Feb 25 19:46:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Feb 25 19:46:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:46:07 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::ClearQueue Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::stop Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::stPlaybackTimer Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::updateTrackBlock Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrackBlock Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::serviceStop Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::serviceStop Feb 25 19:46:14 musical-fidelity volumio[1052]: info: [1740512774476] ControllerTidal::stop Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 19:46:14 musical-fidelity volumio[1052]: info: ControllerMpd::stop Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CorePlayQueue::clearPlayQueue Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CorePlayQueue::saveQueue Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushQueue Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::addQueueItems Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CorePlayQueue::addQueueItems Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766600 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766600 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766601 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766601 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766602 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766602 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766603 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766603 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766604 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766604 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766605 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766605 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766606 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766606 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766607 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766607 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766608 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766608 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766609 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766609 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766610 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766610 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766611 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766611 in service tidal Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Updating push state because input changed Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumiosetSourceActivempd Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Feb 25 19:46:14 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:46:14 musical-fidelity volumio[1052]: info: sendMpdCommand stop took 100 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:46:14 musical-fidelity volumio[1052]: info: sendMpdCommand status took 2 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:46:14 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:46:14 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 0 Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/4380a32032fc2154741942af9a6deb14.mp4?Expires=1740516312&Signature=F9tu1DL7qbMpR-4aoqPvBqcm7p9uqzJr1W~bBFyy8OcQTFNAp3dbJ0n3oMq23Qoi4CFzoZ6gdPR1QlRjpA2EuZr7wJsFOSISE30OLM5BNUz~JIUM2Gz0Z7S2TyaGdfMHh8lguUnuen0cZaeXMyYAxI0Uo1gQhXbC8uhxhUNLbTUXmWl06htY4AvTuLcTW~B7nytFMroN25JPpFi0cSPuCWdOGLBOpw6wT2D5vka-lZjtC28~cz0tU7PgSTwcWaNL5rtKWSZOov0hCRd6RFsB5rMdKE8NRzwjwe-WUL3agRZA5oK8T-ICsFFSkCqYvx4czmbc2GxQt~UJEb50P8-x0w__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:46:14 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 0 Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService stop Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:14 musical-fidelity volumio[1052]: info: No code Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:14 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:14 musical-fidelity volumio[1052]: info: ------------------------------ 21ms Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 203 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 326 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 334 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 330 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 367 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:14 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 416 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 488 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 496 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 502 milliseconds Feb 25 19:46:14 musical-fidelity volumio[1052]: info: explodeTIDALUri took 506 milliseconds Feb 25 19:46:15 musical-fidelity volumio[1052]: info: explodeTIDALUri took 530 milliseconds Feb 25 19:46:15 musical-fidelity volumio[1052]: info: explodeTIDALUri took 560 milliseconds Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CorePlayQueue::saveQueue Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushQueue Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::updateTrackBlock Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrackBlock Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPlay Feb 25 19:46:15 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::play index 1 Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::stop Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:15 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::play index undefined Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 1 Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::startPlaybackTimer Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 1 Feb 25 19:46:15 musical-fidelity volumio[1052]: info: [1740512775076] ControllerTidal::clearAddPlayTrack Feb 25 19:46:15 musical-fidelity volumio[1052]: info: Getting stream with soundQuality LOW Feb 25 19:46:15 musical-fidelity volumio[1052]: info: getStreamUrl took 301 milliseconds Feb 25 19:46:15 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 19:46:15 musical-fidelity volumio[1052]: info: sendMpdCommand stop took 1 milliseconds Feb 25 19:46:15 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 19:46:15 musical-fidelity volumio[1052]: info: Feb 25 19:46:15 musical-fidelity volumio[1052]: ---------------------------- MPD announces system playlist update Feb 25 19:46:15 musical-fidelity volumio[1052]: info: Ignoring MPD Status Update Feb 25 19:46:15 musical-fidelity volumio[1052]: info: sendMpdCommand clear took 1 milliseconds Feb 25 19:46:15 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "http://amz-pr-cf.audio.tidal.com/3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL" Feb 25 19:46:15 musical-fidelity volumio[1052]: error: updateQueue error: null Feb 25 19:46:15 musical-fidelity volumio[1052]: info: Feb 25 19:46:15 musical-fidelity volumio[1052]: ---------------------------- MPD announces system playlist update Feb 25 19:46:15 musical-fidelity volumio[1052]: info: Ignoring MPD Status Update Feb 25 19:46:15 musical-fidelity volumio[1052]: info: ------------------------------ 3ms Feb 25 19:46:15 musical-fidelity volumio[1052]: info: sendMpdCommand add "http://amz-pr-cf.audio.tidal.com/3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL" took 3 milliseconds Feb 25 19:46:15 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 19:46:15 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand play Feb 25 19:46:15 musical-fidelity volumio[1052]: info: ------------------------------ 3ms Feb 25 19:46:15 musical-fidelity volumio[1052]: info: sendMpdCommand play took 2 milliseconds Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Feb 25 19:46:16 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:46:16 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Feb 25 19:46:16 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:46:16 musical-fidelity volumio[1052]: info: sendMpdCommand status took 8 milliseconds Feb 25 19:46:16 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:46:16 musical-fidelity volumio[1052]: info: sendMpdCommand status took 2 milliseconds Feb 25 19:46:16 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:46:16 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 1 Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 1 Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService play Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:16 musical-fidelity volumio[1052]: info: ------------------------------ 22ms Feb 25 19:46:16 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 12 milliseconds Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:46:16 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 1 Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":488,"duration":242,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:46:16 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 1 Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService play Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus play Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Received an update from plugin. extracting info from payload Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:16 musical-fidelity volumio[1052]: info: ------------------------------ 43ms Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Updating push state because input changed Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumiosetSourceActivempd Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:46:16 musical-fidelity volumio[1052]: info: Discovery: Getting this device information Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioGetState Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:46:16 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConf Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::ClearQueue Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::stop Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:17 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::stPlaybackTimer Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::updateTrackBlock Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrackBlock Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 1 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::serviceStop Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 1 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::serviceStop Feb 25 19:46:17 musical-fidelity volumio[1052]: info: [1740512777801] ControllerTidal::stop Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 19:46:17 musical-fidelity volumio[1052]: info: ControllerMpd::stop Feb 25 19:46:17 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CorePlayQueue::clearPlayQueue Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CorePlayQueue::saveQueue Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushQueue Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreStateMachine::addQueueItems Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CorePlayQueue::addQueueItems Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766600 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766600 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766601 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766601 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766602 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766602 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766603 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766603 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766604 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766604 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766605 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766605 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766606 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766606 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766607 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766607 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766608 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766608 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766609 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766609 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766610 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766610 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766611 Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766611 in service tidal Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Updating push state because input changed Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumiosetSourceActivempd Feb 25 19:46:17 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:17 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 266 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Feb 25 19:46:18 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:46:18 musical-fidelity volumio[1052]: info: sendMpdCommand stop took 332 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 329 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 339 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: sendMpdCommand status took 40 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 423 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 440 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 76 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:46:18 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 1 Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/3d4029a677eefbb44d70589e6e53713c.mp4?Expires=1740516375&Signature=Rv3GwKsAW0SBG5L9XE3l15TauC7mK7VmZuxB6z2FhrDQ62oWVtTQrV2jUS9HuoGhqmIGSlghpXGeB9WRO-UQrqENdK49IgDnuhlEGO8RsJmnWlx-o2fBS48bB8~ix6lCOx6r7Dx8Q9uF4bZk6dhSLR8kaRbYZEHQZF5Cd5-4ETFw5DsxXktyJdjVXjw4Nd26qKE0~TOQ0BDRk8x5IPn8Y9-P~fBMupy83ssXAndB9AKh6xH9-4o1ff4cGUgWTAx-mvYe8Fu4GApR3g4rXO1wC7ERqm6iNSNhBFm3mUxZ8Ql5tsTKdu~uK3R6jE0aKs8tUT0fatrVMbIHcat0efC0VA__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 1 Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService stop Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:18 musical-fidelity volumio[1052]: info: No code Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:18 musical-fidelity volumio[1052]: info: ------------------------------ 143ms Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 459 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 472 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 469 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 477 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 546 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 555 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: explodeTIDALUri took 551 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CorePlayQueue::saveQueue Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushQueue Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::updateTrackBlock Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrackBlock Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPlay Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::play index 2 Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::stop Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::play index undefined Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 2 Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::startPlaybackTimer Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 2 Feb 25 19:46:18 musical-fidelity volumio[1052]: info: [1740512778378] ControllerTidal::clearAddPlayTrack Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Getting stream with soundQuality LOW Feb 25 19:46:18 musical-fidelity volumio[1052]: info: getStreamUrl took 313 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 19:46:18 musical-fidelity volumio[1052]: info: sendMpdCommand stop took 1 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Feb 25 19:46:18 musical-fidelity volumio[1052]: ---------------------------- MPD announces system playlist update Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Ignoring MPD Status Update Feb 25 19:46:18 musical-fidelity volumio[1052]: info: sendMpdCommand clear took 5 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand add "http://amz-pr-cf.audio.tidal.com/42e4007dafd191f7b9deb157af0645e4.mp4?Expires=1740516378&Signature=oGramGdnVz3Bqf4qLttQ29L1~34RzsnBuG3bt9O-vQhCj4kmVGJYYnYqciziSr086FBh6~HK5el12v~XGVk0kf9POoA4tevtXqPaNKSnEdjoQlBhZ5k0lfdiq7f6FbWMrwDJPYxsMAYQN~AZYwAkdQ1ybvhCd57qnTSIhsQnI-iFZlMquwDa4eX3Dyt~WUa2XFgsbI9yFB2oZ7-KuaAj6Sx9TQ9CBrU8TG6FY46ajsHXgwxxxtpwfhBOD6yPVa-FsHZbp~L58PxzYPptUVXCWeJ8as5uCFcAJ7YkEA9MlJUgXWgejuhMMleCKOxR7t9gYW42yh2jAKizmkLvILcsjA__&Key-Pair-Id=K14LZCZ9QUI4JL" Feb 25 19:46:18 musical-fidelity volumio[1052]: error: updateQueue error: null Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Feb 25 19:46:18 musical-fidelity volumio[1052]: ---------------------------- MPD announces system playlist update Feb 25 19:46:18 musical-fidelity volumio[1052]: info: Ignoring MPD Status Update Feb 25 19:46:18 musical-fidelity volumio[1052]: info: ------------------------------ 13ms Feb 25 19:46:18 musical-fidelity volumio[1052]: info: sendMpdCommand add "http://amz-pr-cf.audio.tidal.com/42e4007dafd191f7b9deb157af0645e4.mp4?Expires=1740516378&Signature=oGramGdnVz3Bqf4qLttQ29L1~34RzsnBuG3bt9O-vQhCj4kmVGJYYnYqciziSr086FBh6~HK5el12v~XGVk0kf9POoA4tevtXqPaNKSnEdjoQlBhZ5k0lfdiq7f6FbWMrwDJPYxsMAYQN~AZYwAkdQ1ybvhCd57qnTSIhsQnI-iFZlMquwDa4eX3Dyt~WUa2XFgsbI9yFB2oZ7-KuaAj6Sx9TQ9CBrU8TG6FY46ajsHXgwxxxtpwfhBOD6yPVa-FsHZbp~L58PxzYPptUVXCWeJ8as5uCFcAJ7YkEA9MlJUgXWgejuhMMleCKOxR7t9gYW42yh2jAKizmkLvILcsjA__&Key-Pair-Id=K14LZCZ9QUI4JL" took 2 milliseconds Feb 25 19:46:18 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 19:46:18 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand play Feb 25 19:46:18 musical-fidelity volumio[1052]: info: ------------------------------ 2ms Feb 25 19:46:18 musical-fidelity volumio[1052]: info: sendMpdCommand play took 1 milliseconds Feb 25 19:46:19 musical-fidelity volumio[1052]: info: Feb 25 19:46:19 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:46:19 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:46:19 musical-fidelity volumio[1052]: info: Feb 25 19:46:19 musical-fidelity volumio[1052]: ---------------------------- MPD announces state update: player Feb 25 19:46:19 musical-fidelity volumio[1052]: info: ControllerMpd::getState Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand status Feb 25 19:46:19 musical-fidelity volumio[1052]: info: sendMpdCommand status took 11 milliseconds Feb 25 19:46:19 musical-fidelity volumio[1052]: info: sendMpdCommand status took 11 milliseconds Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseState Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 19:46:19 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 25 19:46:19 musical-fidelity volumio[1052]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: ControllerMpd::parseTrackInfo Feb 25 19:46:19 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 2 Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":488,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"42e4007dafd191f7b9deb157af0645e4.mp4?Expires=1740516378&Signature=oGramGdnVz3Bqf4qLttQ29L1~34RzsnBuG3bt9O-vQhCj4kmVGJYYnYqciziSr086FBh6~HK5el12v~XGVk0kf9POoA4tevtXqPaNKSnEdjoQlBhZ5k0lfdiq7f6FbWMrwDJPYxsMAYQN~AZYwAkdQ1ybvhCd57qnTSIhsQnI-iFZlMquwDa4eX3Dyt~WUa2XFgsbI9yFB2oZ7-KuaAj6Sx9TQ9CBrU8TG6FY46ajsHXgwxxxtpwfhBOD6yPVa-FsHZbp~L58PxzYPptUVXCWeJ8as5uCFcAJ7YkEA9MlJUgXWgejuhMMleCKOxR7t9gYW42yh2jAKizmkLvILcsjA__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/42e4007dafd191f7b9deb157af0645e4.mp4?Expires=1740516378&Signature=oGramGdnVz3Bqf4qLttQ29L1~34RzsnBuG3bt9O-vQhCj4kmVGJYYnYqciziSr086FBh6~HK5el12v~XGVk0kf9POoA4tevtXqPaNKSnEdjoQlBhZ5k0lfdiq7f6FbWMrwDJPYxsMAYQN~AZYwAkdQ1ybvhCd57qnTSIhsQnI-iFZlMquwDa4eX3Dyt~WUa2XFgsbI9yFB2oZ7-KuaAj6Sx9TQ9CBrU8TG6FY46ajsHXgwxxxtpwfhBOD6yPVa-FsHZbp~L58PxzYPptUVXCWeJ8as5uCFcAJ7YkEA9MlJUgXWgejuhMMleCKOxR7t9gYW42yh2jAKizmkLvILcsjA__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 2 Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService play Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:19 musical-fidelity volumio[1052]: info: ControllerMpd::pushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::servicePushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 2 Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":488,"duration":264,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"42e4007dafd191f7b9deb157af0645e4.mp4?Expires=1740516378&Signature=oGramGdnVz3Bqf4qLttQ29L1~34RzsnBuG3bt9O-vQhCj4kmVGJYYnYqciziSr086FBh6~HK5el12v~XGVk0kf9POoA4tevtXqPaNKSnEdjoQlBhZ5k0lfdiq7f6FbWMrwDJPYxsMAYQN~AZYwAkdQ1ybvhCd57qnTSIhsQnI-iFZlMquwDa4eX3Dyt~WUa2XFgsbI9yFB2oZ7-KuaAj6Sx9TQ9CBrU8TG6FY46ajsHXgwxxxtpwfhBOD6yPVa-FsHZbp~L58PxzYPptUVXCWeJ8as5uCFcAJ7YkEA9MlJUgXWgejuhMMleCKOxR7t9gYW42yh2jAKizmkLvILcsjA__&Key-Pair-Id=K14LZCZ9QUI4JL","artist":null,"album":null,"uri":"http://amz-pr-cf.audio.tidal.com/42e4007dafd191f7b9deb157af0645e4.mp4?Expires=1740516378&Signature=oGramGdnVz3Bqf4qLttQ29L1~34RzsnBuG3bt9O-vQhCj4kmVGJYYnYqciziSr086FBh6~HK5el12v~XGVk0kf9POoA4tevtXqPaNKSnEdjoQlBhZ5k0lfdiq7f6FbWMrwDJPYxsMAYQN~AZYwAkdQ1ybvhCd57qnTSIhsQnI-iFZlMquwDa4eX3Dyt~WUa2XFgsbI9yFB2oZ7-KuaAj6Sx9TQ9CBrU8TG6FY46ajsHXgwxxxtpwfhBOD6yPVa-FsHZbp~L58PxzYPptUVXCWeJ8as5uCFcAJ7YkEA9MlJUgXWgejuhMMleCKOxR7t9gYW42yh2jAKizmkLvILcsjA__&Key-Pair-Id=K14LZCZ9QUI4JL","trackType":"tidal"} Feb 25 19:46:19 musical-fidelity volumio[1052]: verbose: CURRENT POSITION 2 Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState stateService play Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreStateMachine::syncState currentStatus play Feb 25 19:46:19 musical-fidelity volumio[1052]: info: Received an update from plugin. extracting info from payload Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:19 musical-fidelity volumio[1052]: info: ------------------------------ 45ms Feb 25 19:46:19 musical-fidelity volumio[1052]: info: ------------------------------ 44ms Feb 25 19:46:19 musical-fidelity volumio[1052]: info: Updating push state because input changed Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumiosetSourceActivempd Feb 25 19:46:19 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 19:46:19 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:19 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:19 musical-fidelity volumio[1052]: info: Updating RAAT Signal Path Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::ClearQueue Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::stop Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 19:46:23 musical-fidelity volumio[1052]: verbose: UNSET VOLATILE Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::stPlaybackTimer Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::updateTrackBlock Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrackBlock Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::pushState Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 2 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::serviceStop Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CorePlayQueue::getTrack 2 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::serviceStop Feb 25 19:46:23 musical-fidelity volumio[1052]: info: [1740512783046] ControllerTidal::stop Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 19:46:23 musical-fidelity volumio[1052]: info: ControllerMpd::stop Feb 25 19:46:23 musical-fidelity volumio[1052]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CorePlayQueue::clearPlayQueue Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CorePlayQueue::saveQueue Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushState Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumioPushQueue Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreStateMachine::addQueueItems Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CorePlayQueue::addQueueItems Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766600 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766600 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766601 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766601 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766602 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766602 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766603 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766603 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766604 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766604 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766605 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766605 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766606 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766606 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766607 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766607 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766608 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766608 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766609 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766609 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766610 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766610 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Adding Item to queue: tidal://song/252766611 Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Exploding uri tidal://song/252766611 in service tidal Feb 25 19:46:23 musical-fidelity volumio[1052]: info: Updating push state because input changed Feb 25 19:46:23 musical-fidelity volumio[1052]: info: CoreCommandRouter::volumiosetSourceActivempd Feb 25 19:46:23 musical-fidelity systemd-journal[18205]: Runtime journal is using 20.0M (max allowed 30.0M, trying to leave 70.4M free of 448.9M available → current limit 30.0M). Feb 25 19:46:23 musical-fidelity kernel: Unable to handle kernel NULL pointer dereference at virtual address 00000222 Feb 25 19:46:23 musical-fidelity kernel: pgd = b9220000 Feb 25 19:46:23 musical-fidelity kernel: [00000222] *pgd=00000000 Feb 25 19:46:23 musical-fidelity kernel: Internal error: Oops: 5 [#2] SMP ARM Feb 25 19:46:23 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 cfg80211 snd_hwdep btusb(O) snd_usbmidi_lib btrtl(O) snd_seq_midi snd_seq_midi_event btintel(O) btbcm(O) snd_rawmidi bluetooth snd_pcm snd_seq snd_seq_device snd_timer rfkill snd bcm2835_gpiomem fixed uio_pdrv_genirq uio i2c_dev ipv6 fuse squashfs overlay Feb 25 19:46:23 musical-fidelity kernel: CPU: 3 PID: 197 Comm: systemd-journal Tainted: G D O 4.9.65-v7+ #1 Feb 25 19:46:23 musical-fidelity kernel: Hardware name: BCM2835 Feb 25 19:46:23 musical-fidelity kernel: task: b9098000 task.stack: b920e000 Feb 25 19:46:23 musical-fidelity kernel: PC is at skb_release_data+0x64/0x128 Feb 25 19:46:23 musical-fidelity kernel: LR is at skb_release_all+0x30/0x34 Feb 25 19:46:23 musical-fidelity kernel: pc : [<805fff80>] lr : [<80600074>] psr: 60000013 sp : b920fd78 ip : b920fd98 fp : b920fd94 Feb 25 19:46:23 musical-fidelity kernel: r10: b562f900 r9 : 00000000 r8 : 00000000 Feb 25 19:46:23 musical-fidelity kernel: r7 : 00000222 r6 : b56d7d80 r5 : b56d7d80 r4 : b56d7d80 Feb 25 19:46:23 musical-fidelity kernel: r3 : 00000000 r2 : 00000001 r1 : 00000000 r0 : b56d7d80 Feb 25 19:46:23 musical-fidelity kernel: Flags: nZCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user Feb 25 19:46:23 musical-fidelity kernel: Control: 10c5383d Table: 3922006a DAC: 00000055 Feb 25 19:46:23 musical-fidelity kernel: Process systemd-journal (pid: 197, stack limit = 0xb920e210) Feb 25 19:46:23 musical-fidelity kernel: Stack: (0xb920fd78 to 0xb9210000) Feb 25 19:46:23 musical-fidelity kernel: fd60: b56d7d80 b56d7d80 Feb 25 19:46:23 musical-fidelity kernel: fd80: b920fe5c 000007b8 b920fdac b920fd98 80600074 805fff28 00000001 b56d7d80 Feb 25 19:46:23 musical-fidelity kernel: fda0: b920fdc4 b920fdb0 806001f8 80600050 b56d7d80 00000048 b920fe54 b920fdc8 Feb 25 19:46:23 musical-fidelity kernel: fdc0: 806c2264 806001cc 00000000 00000000 b562fa44 00000001 00000000 00000001 Feb 25 19:46:23 musical-fidelity kernel: fde0: b562fb0c 00000000 b562fb4c b59f9dc0 00000048 00000001 00000048 b562f984 Feb 25 19:46:23 musical-fidelity kernel: fe00: baa42c00 00000000 0000041c 000003e8 000003e8 b92a2360 b920fe48 8028727c Feb 25 19:46:23 musical-fidelity kernel: fe20: 67be1e0f 0af4af3f b920fe6c 00000000 b920ff00 b920fee8 b920ff78 00000800 Feb 25 19:46:23 musical-fidelity kernel: fe40: 01243081 00000000 b920fe84 b920fe58 806c2410 806c1b10 806bdb84 806be394 Feb 25 19:46:23 musical-fidelity kernel: fe60: b59f9dc0 b920fe88 00000000 00000800 00000040 00000000 b920fed4 b920fe88 Feb 25 19:46:23 musical-fidelity kernel: fe80: 805f71e0 806c23d4 00000000 00000000 00000000 00000048 000007b8 b920fee0 Feb 25 19:46:23 musical-fidelity kernel: fea0: 00000001 805c88c0 00000000 00000000 00000040 b920ff00 ba9a2aac 00000000 Feb 25 19:46:23 musical-fidelity kernel: fec0: 00000000 b7aae480 b920ff44 b920fed8 80268b64 805f7150 00000800 0000001e Feb 25 19:46:23 musical-fidelity kernel: fee0: 01243081 00000800 00000000 00000000 00000800 b920fee0 00000001 805c88c0 Feb 25 19:46:23 musical-fidelity kernel: ff00: b7aae480 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Feb 25 19:46:23 musical-fidelity kernel: ff20: 8017ea84 00000800 b7aae480 01243081 b920ff78 00000800 b920ff74 b920ff48 Feb 25 19:46:23 musical-fidelity kernel: ff40: 8026996c 80268aa0 00000268 80289034 b920ff74 00000000 00000000 b7aae480 Feb 25 19:46:23 musical-fidelity kernel: ff60: b7aae480 00000800 b920ffa4 b920ff78 8026ab28 802698e0 00000000 00000000 Feb 25 19:46:23 musical-fidelity kernel: ff80: 01243058 76fc3f10 7ef6f728 00000003 80107fa4 b920e000 00000000 b920ffa8 Feb 25 19:46:23 musical-fidelity kernel: ffa0: 80107e20 8026aae8 01243058 76fc3f10 0000000f 01243081 00000800 00000011 Feb 25 19:46:23 musical-fidelity kernel: ffc0: 01243058 76fc3f10 7ef6f728 00000003 76fc3f10 012380a0 01238088 7ef6fa1c Feb 25 19:46:23 musical-fidelity kernel: ffe0: 00000000 7ef6f704 00422e78 76f7ac8c 60000010 0000000f 3b7fa861 3b7fac61 Feb 25 19:46:23 musical-fidelity kernel: [<805fff80>] (skb_release_data) from [<80600074>] (skb_release_all+0x30/0x34) Feb 25 19:46:23 musical-fidelity kernel: [<80600074>] (skb_release_all) from [<806001f8>] (consume_skb+0x38/0xe4) Feb 25 19:46:23 musical-fidelity kernel: [<806001f8>] (consume_skb) from [<806c2264>] (unix_stream_read_generic+0x760/0x834) Feb 25 19:46:23 musical-fidelity kernel: [<806c2264>] (unix_stream_read_generic) from [<806c2410>] (unix_stream_recvmsg+0x48/0x54) Feb 25 19:46:23 musical-fidelity kernel: [<806c2410>] (unix_stream_recvmsg) from [<805f71e0>] (sock_read_iter+0x9c/0xd0) Feb 25 19:46:23 musical-fidelity kernel: [<805f71e0>] (sock_read_iter) from [<80268b64>] (__vfs_read+0xd0/0x120) Feb 25 19:46:23 musical-fidelity kernel: [<80268b64>] (__vfs_read) from [<8026996c>] (vfs_read+0x98/0x16c) Feb 25 19:46:23 musical-fidelity kernel: [<8026996c>] (vfs_read) from [<8026ab28>] (SyS_read+0x4c/0xa0) Feb 25 19:46:23 musical-fidelity kernel: [<8026ab28>] (SyS_read) from [<80107e20>] (ret_fast_syscall+0x0/0x1c) Feb 25 19:46:23 musical-fidelity kernel: Code: 1afffffa f57ff05b e3510000 189da8f0 (e5d73000) Feb 25 19:46:23 musical-fidelity kernel: ---[ end trace d7a07d29e52b8ca3 ]--- Feb 25 19:46:23 musical-fidelity systemd[1]: systemd-journald.service has no holdoff time, scheduling restart. Feb 25 19:46:23 musical-fidelity systemd[1]: Stopping Journal Service... Feb 25 19:46:23 musical-fidelity systemd[1]: Starting Journal Service... Feb 25 19:46:23 musical-fidelity systemd[1]: Started Journal Service. Feb 25 19:46:23 musical-fidelity systemd-journal[18205]: Journal started Feb 25 19:46:23 musical-fidelity systemd[1]: systemd-journald.service: main process exited, code=killed, status=11/SEGV Feb 25 19:46:23 musical-fidelity systemd[1]: Unit systemd-journald.service entered failed state. Feb 25 19:46:23 musical-fidelity systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Feb 25 19:46:23 musical-fidelity systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Feb 25 19:46:24 musical-fidelity sudo[18221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-25 19:45 Feb 25 19:46:24 musical-fidelity sudo[18221]: 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"