-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2025-10-29 08:37:56 CET. -- Oct 29 08:36:19 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:36:19 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:36:19 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:36:19 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:19 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:19 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:36:19 primo volumio[1123]: verbose: New Socket.io Connection to 192.168.2.4:3000 from 192.168.2.2 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Oct 29 08:36:20 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:20 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:20 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 29 08:36:20 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 29 08:36:21 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:36:21 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:36:21 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:36:21 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:21 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:21 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:36:24 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:24 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:25 primo sudo[26591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 08:36:25 primo sudo[26593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 08:36:25 primo sudo[26591]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 08:36:25 primo sudo[26593]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 08:36:25 primo sudo[26591]: pam_unix(sudo:session): session closed for user root Oct 29 08:36:25 primo sudo[26593]: pam_unix(sudo:session): session closed for user root Oct 29 08:36:25 primo volumio[1123]: verbose: New Socket.io Connection to 192.168.2.4 from 192.168.2.2 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 29 08:36:25 primo sudo[26612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 29 08:36:25 primo sudo[26612]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 08:36:25 primo sudo[26615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 29 08:36:25 primo sudo[26612]: pam_unix(sudo:session): session closed for user root Oct 29 08:36:25 primo sudo[26615]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 29 08:36:25 primo sudo[26615]: pam_unix(sudo:session): session closed for user root Oct 29 08:36:25 primo volumio[1123]: verbose: New Socket.io Connection to 192.168.2.4 from 192.168.2.2 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::volumioGetVisibleSources Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:25 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 29 08:36:25 primo volumio[1123]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 29 08:36:25 primo volumio[1123]: info: Received Get System Info Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:36:25 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:25 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:25 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:25 primo volumio[1123]: info: Listing playlists Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 29 08:36:25 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 1334 Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:36:26 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:26 primo volumio[1123]: info: Oct 29 08:36:26 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand stop took 33 milliseconds Oct 29 08:36:26 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand status took 7 milliseconds Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand stop took 3 milliseconds Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:36:26 primo volumio[1123]: info: Oct 29 08:36:26 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:26 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand clear took 4 milliseconds Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac" Oct 29 08:36:26 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: 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":"Od Scra","artist":"Boban i Marko Markovic Orkestar","album":"Golden Horns - Best of Boban i Marko Markovic Orkestar","uri":"USB/E395-1170/Muziek Volumio Keuken/Boban Markovic - Golden Horns - Best of Boban i Marko Markovic Orkestar 16-44.1 FLAC/Boban Markovic - Golden Horns - Best of Boban i Marko Markovic Orkestar 16-44.1 FLAC/1.06. Od Scra.flac","trackType":"flac"} Oct 29 08:36:26 primo volumio[1123]: verbose: CURRENT POSITION 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: No code Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: ------------------------------ 45ms Oct 29 08:36:26 primo volumio[1123]: error: updateQueue error: null Oct 29 08:36:26 primo volumio[1123]: info: Oct 29 08:36:26 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:26 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:26 primo volumio[1123]: info: ------------------------------ 37ms Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac" took 35 milliseconds Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:36:26 primo volumio[1123]: info: Oct 29 08:36:26 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:26 primo volumio[1123]: info: ------------------------------ 32ms Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand play took 31 milliseconds Oct 29 08:36:26 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:26 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:36:26 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:36:26 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:26 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:26 primo volumio[1123]: info: Oct 29 08:36:26 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand status took 46 milliseconds Oct 29 08:36:26 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand status took 9 milliseconds Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:26 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"650 Kbps","isStreaming":false,"title":"Why Are You Leaving?","artist":"Level 42","album":"5 Classic Albums","uri":"USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac","trackType":"flac"} Oct 29 08:36:26 primo volumio[1123]: verbose: CURRENT POSITION 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:26 primo volumio[1123]: info: ------------------------------ 65ms Oct 29 08:36:26 primo volumio[1123]: info: sendMpdCommand playlistinfo took 34 milliseconds Oct 29 08:36:26 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:26 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"650 Kbps","isStreaming":false,"title":"Why Are You Leaving?","artist":"Level 42","album":"5 Classic Albums","uri":"USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac","trackType":"flac"} Oct 29 08:36:26 primo volumio[1123]: verbose: CURRENT POSITION 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:26 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:26 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:26 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:26 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:26 primo volumio[1123]: info: ------------------------------ 93ms Oct 29 08:36:26 primo volumio[1123]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 08:36:27 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 29 08:36:27 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 08:36:27 primo volumio[1123]: info: Received Get System Info Oct 29 08:36:27 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:36:27 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:36:27 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:36:27 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:27 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:27 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 29 08:36:28 primo volumio[1123]: info: Received Get System Info Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:36:28 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:28 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:36:28 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:28 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:28 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:35 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::volumioSeek Oct 29 08:36:39 primo volumio[1123]: info: CoreStateMachine::seek Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: info: TRACKBLOCK {"uri":"mnt/USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac","service":"mpd","name":"Why Are You Leaving?","artist":"Level 42","album":"5 Classic Albums","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=613&web=Level%2042/5%20Classic%20Albums/extralarge&path=%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FLevel%2042%20-%205%20Classic%20Albums%20(2015)%20%5BFLAC%5D%20%7B5363745%7D%2FCD%201%20-%20Level%2042%20(1981)&metadata=false","duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Oct 29 08:36:39 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: info: ControllerMpd::seek Oct 29 08:36:39 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:39 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:39 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: error: null Oct 29 08:36:39 primo volumio[1123]: info: Oct 29 08:36:39 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:39 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:39 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:39 primo volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 29 08:36:39 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:39 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:39 primo volumio[1123]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 08:36:39 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:39 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":120000,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"689 Kbps","isStreaming":false,"title":"Why Are You Leaving?","artist":"Level 42","album":"5 Classic Albums","uri":"USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac","trackType":"flac"} Oct 29 08:36:39 primo volumio[1123]: verbose: CURRENT POSITION 3435 Oct 29 08:36:39 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:39 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:39 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:39 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:39 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:39 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:39 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:39 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:39 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:39 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:39 primo volumio[1123]: info: ------------------------------ 39ms Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 3435 Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:36:42 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:42 primo volumio[1123]: info: Oct 29 08:36:42 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand stop took 17 milliseconds Oct 29 08:36:42 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand status took 7 milliseconds Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand stop took 4 milliseconds Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:36:42 primo volumio[1123]: info: Oct 29 08:36:42 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:42 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand clear took 12 milliseconds Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac" Oct 29 08:36:42 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: 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":"Why Are You Leaving?","artist":"Level 42","album":"5 Classic Albums","uri":"USB/E395-1170/Muziek Volumio Keuken/Level 42 - 5 Classic Albums (2015) [FLAC] {5363745}/CD 1 - Level 42 (1981)/03 - Why Are You Leaving.flac","trackType":"flac"} Oct 29 08:36:42 primo volumio[1123]: verbose: CURRENT POSITION 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: No code Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: ------------------------------ 58ms Oct 29 08:36:42 primo volumio[1123]: error: updateQueue error: null Oct 29 08:36:42 primo volumio[1123]: info: Oct 29 08:36:42 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:42 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:42 primo volumio[1123]: info: ------------------------------ 43ms Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac" took 41 milliseconds Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:36:42 primo volumio[1123]: info: Oct 29 08:36:42 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:42 primo volumio[1123]: info: ------------------------------ 80ms Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand play took 80 milliseconds Oct 29 08:36:42 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:42 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:36:42 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:36:42 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:42 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:42 primo volumio[1123]: info: Oct 29 08:36:42 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:42 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand status took 28 milliseconds Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand status took 30 milliseconds Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:42 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"378 Kbps","isStreaming":false,"title":"The Good, The Bad, and the Primary","artist":"Stephen Barton","album":"12 Monkeys (Original Series Soundtrack)","uri":"USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac","trackType":"flac"} Oct 29 08:36:42 primo volumio[1123]: verbose: CURRENT POSITION 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:42 primo volumio[1123]: info: ------------------------------ 67ms Oct 29 08:36:42 primo volumio[1123]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 29 08:36:42 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:42 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"378 Kbps","isStreaming":false,"title":"The Good, The Bad, and the Primary","artist":"Stephen Barton","album":"12 Monkeys (Original Series Soundtrack)","uri":"USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac","trackType":"flac"} Oct 29 08:36:42 primo volumio[1123]: verbose: CURRENT POSITION 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:42 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:42 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:42 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:42 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:42 primo volumio[1123]: info: ------------------------------ 97ms Oct 29 08:36:42 primo volumio[1123]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 08:36:43 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 29 08:36:43 primo volumio[1123]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 29 08:36:43 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 29 08:36:43 primo volumio[1123]: info: Received Get System Version Oct 29 08:36:43 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 08:36:43 primo volumio[1123]: info: Received Get System Info Oct 29 08:36:43 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:36:43 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:36:43 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:36:43 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:43 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:43 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:36:44 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:44 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:44 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:44 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:44 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:44 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::volumioSeek Oct 29 08:36:45 primo volumio[1123]: info: CoreStateMachine::seek Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: info: TRACKBLOCK {"uri":"mnt/USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac","service":"mpd","name":"The Good, The Bad, and the Primary","artist":"Stephen Barton","album":"12 Monkeys (Original Series Soundtrack)","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=613&web=Stephen%20Barton/12%20Monkeys%20(Original%20Series%20Soundtrack)/extralarge&path=%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2F2018-12-Monkeys-FLAC-WEB%2F2018%2012%20Monkeys%20(Original%20Series%20Soundtrack)%20FLAC%20WEB&metadata=false","duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Oct 29 08:36:45 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: info: ControllerMpd::seek Oct 29 08:36:45 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:45 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:45 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: error: null Oct 29 08:36:45 primo volumio[1123]: info: Oct 29 08:36:45 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:45 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:45 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:45 primo volumio[1123]: info: sendMpdCommand status took 7 milliseconds Oct 29 08:36:45 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:45 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:45 primo volumio[1123]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:36:45 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:45 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102212,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"505 Kbps","isStreaming":false,"title":"The Good, The Bad, and the Primary","artist":"Stephen Barton","album":"12 Monkeys (Original Series Soundtrack)","uri":"USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac","trackType":"flac"} Oct 29 08:36:45 primo volumio[1123]: verbose: CURRENT POSITION 614 Oct 29 08:36:45 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:45 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:45 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:45 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:45 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:45 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:45 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:45 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:45 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:45 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:45 primo volumio[1123]: info: ------------------------------ 40ms Oct 29 08:36:47 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:36:47 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:36:47 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:36:47 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:47 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:47 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:47 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:47 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:47 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:47 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:47 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:47 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:47 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:47 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:47 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:47 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:36:47 primo volumio[1123]: info: CorePlayQueue::getTrack 614 Oct 29 08:36:47 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:36:47 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:36:47 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:48 primo volumio[1123]: info: Oct 29 08:36:48 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand stop took 99 milliseconds Oct 29 08:36:48 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/Underworld and Gabriel Yared - Breaking and Entering/07 We Love Bea.flac Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand status took 29 milliseconds Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand stop took 26 milliseconds Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:36:48 primo volumio[1123]: info: Oct 29 08:36:48 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:48 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand clear took 20 milliseconds Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Underworld and Gabriel Yared - Breaking and Entering/07 We Love Bea.flac" Oct 29 08:36:48 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: 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":"The Good, The Bad, and the Primary","artist":"Stephen Barton","album":"12 Monkeys (Original Series Soundtrack)","uri":"USB/E395-1170/Muziek Volumio Keuken/2018-12-Monkeys-FLAC-WEB/2018 12 Monkeys (Original Series Soundtrack) FLAC WEB/07. The Good, The Bad, And The Primary.flac","trackType":"flac"} Oct 29 08:36:48 primo volumio[1123]: verbose: CURRENT POSITION 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: No code Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: ------------------------------ 156ms Oct 29 08:36:48 primo volumio[1123]: error: updateQueue error: null Oct 29 08:36:48 primo volumio[1123]: info: Oct 29 08:36:48 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:48 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:48 primo volumio[1123]: info: ------------------------------ 150ms Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Underworld and Gabriel Yared - Breaking and Entering/07 We Love Bea.flac" took 149 milliseconds Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:36:48 primo volumio[1123]: info: Oct 29 08:36:48 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:48 primo volumio[1123]: info: ------------------------------ 42ms Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand play took 37 milliseconds Oct 29 08:36:48 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:48 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:36:48 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:36:48 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:48 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:48 primo volumio[1123]: info: Oct 29 08:36:48 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand status took 17 milliseconds Oct 29 08:36:48 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand status took 3 milliseconds Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:48 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":113,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"We Love Bea","artist":"Underworld and Gabriel Yared","album":"Breaking and Entering","uri":"USB/E395-1170/Muziek Volumio Keuken/Underworld and Gabriel Yared - Breaking and Entering/07 We Love Bea.flac","trackType":"flac"} Oct 29 08:36:48 primo volumio[1123]: verbose: CURRENT POSITION 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:48 primo volumio[1123]: info: ------------------------------ 25ms Oct 29 08:36:48 primo volumio[1123]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 08:36:48 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:48 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":113,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"442 Kbps","isStreaming":false,"title":"We Love Bea","artist":"Underworld and Gabriel Yared","album":"Breaking and Entering","uri":"USB/E395-1170/Muziek Volumio Keuken/Underworld and Gabriel Yared - Breaking and Entering/07 We Love Bea.flac","trackType":"flac"} Oct 29 08:36:48 primo volumio[1123]: verbose: CURRENT POSITION 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:48 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:48 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: ------------------------------ 36ms Oct 29 08:36:48 primo volumio[1123]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:36:48 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:48 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:36:48 primo volumio[1123]: info: camilladsp spawned new process with pid 26711, instance 1, run: true Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 4898 Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:36:49 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:49 primo volumio[1123]: info: Oct 29 08:36:49 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand stop took 19 milliseconds Oct 29 08:36:49 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/be_living/02 - Living Time - Event II.flac Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand status took 4 milliseconds Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand stop took 1 milliseconds Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:36:49 primo volumio[1123]: info: Oct 29 08:36:49 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:49 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand clear took 2 milliseconds Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/be_living/02 - Living Time - Event II.flac" Oct 29 08:36:49 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: 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":"We Love Bea","artist":"Underworld and Gabriel Yared","album":"Breaking and Entering","uri":"USB/E395-1170/Muziek Volumio Keuken/Underworld and Gabriel Yared - Breaking and Entering/07 We Love Bea.flac","trackType":"flac"} Oct 29 08:36:49 primo volumio[1123]: verbose: CURRENT POSITION 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: No code Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: ------------------------------ 53ms Oct 29 08:36:49 primo volumio[1123]: error: updateQueue error: null Oct 29 08:36:49 primo volumio[1123]: info: Oct 29 08:36:49 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:49 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:49 primo volumio[1123]: info: ------------------------------ 49ms Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/be_living/02 - Living Time - Event II.flac" took 48 milliseconds Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:36:49 primo volumio[1123]: info: Oct 29 08:36:49 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:49 primo volumio[1123]: info: ------------------------------ 84ms Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand play took 83 milliseconds Oct 29 08:36:49 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:49 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:36:49 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:36:49 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:49 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:49 primo volumio[1123]: info: Oct 29 08:36:49 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:49 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand status took 8 milliseconds Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand status took 9 milliseconds Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:49 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":505,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"454 Kbps","isStreaming":false,"title":"Living Time - Event II","artist":"Bill Evans & George Russell Orchestra","album":"Living Time","uri":"USB/E395-1170/Muziek Volumio Keuken/be_living/02 - Living Time - Event II.flac","trackType":"flac"} Oct 29 08:36:49 primo volumio[1123]: verbose: CURRENT POSITION 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:49 primo volumio[1123]: info: ------------------------------ 23ms Oct 29 08:36:49 primo volumio[1123]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 29 08:36:49 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:49 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":505,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"454 Kbps","isStreaming":false,"title":"Living Time - Event II","artist":"Bill Evans & George Russell Orchestra","album":"Living Time","uri":"USB/E395-1170/Muziek Volumio Keuken/be_living/02 - Living Time - Event II.flac","trackType":"flac"} Oct 29 08:36:49 primo volumio[1123]: verbose: CURRENT POSITION 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:49 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:49 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:49 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:49 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:49 primo volumio[1123]: info: ------------------------------ 59ms Oct 29 08:36:49 primo volumio[1123]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 5700 Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:36:51 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:51 primo volumio[1123]: info: Oct 29 08:36:51 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand stop took 20 milliseconds Oct 29 08:36:51 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/Sílvia Pérez Cruz - Toda la vida, un día Hi-Res/Sílvia Pérez Cruz - Toda la vida, un día (2023) Hi-Res/01. Ell no vol que el món s'acabi (Mov.1 La Flor).flac Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand status took 4 milliseconds Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand stop took 2 milliseconds Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:51 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: 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":"Living Time - Event II","artist":"Bill Evans & George Russell Orchestra","album":"Living Time","uri":"USB/E395-1170/Muziek Volumio Keuken/be_living/02 - Living Time - Event II.flac","trackType":"flac"} Oct 29 08:36:51 primo volumio[1123]: verbose: CURRENT POSITION 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: No code Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: ------------------------------ 49ms Oct 29 08:36:51 primo volumio[1123]: info: Oct 29 08:36:51 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:51 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand clear took 44 milliseconds Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Sílvia Pérez Cruz - Toda la vida, un día Hi-Res/Sílvia Pérez Cruz - Toda la vida, un día (2023) Hi-Res/01. Ell no vol que el món s'acabi (Mov.1 La Flor).flac" Oct 29 08:36:51 primo volumio[1123]: error: updateQueue error: null Oct 29 08:36:51 primo volumio[1123]: info: Oct 29 08:36:51 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:51 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:51 primo volumio[1123]: info: ------------------------------ 22ms Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Sílvia Pérez Cruz - Toda la vida, un día Hi-Res/Sílvia Pérez Cruz - Toda la vida, un día (2023) Hi-Res/01. Ell no vol que el món s'acabi (Mov.1 La Flor).flac" took 21 milliseconds Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:36:51 primo volumio[1123]: info: Oct 29 08:36:51 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:51 primo volumio[1123]: info: ------------------------------ 8ms Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand play took 7 milliseconds Oct 29 08:36:51 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:51 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: Oct 29 08:36:51 primo volumio[1123]: error: FusionDsp - invalid sample rate Oct 29 08:36:51 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:36:51 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:36:51 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:51 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:51 primo volumio[1123]: info: Oct 29 08:36:51 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand status took 34 milliseconds Oct 29 08:36:51 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand status took 6 milliseconds Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:51 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ell no vol que el món s'acabi (Mov.1: La Flor)","artist":"Sílvia Pérez Cruz","album":"Toda la vida, un día","uri":"USB/E395-1170/Muziek Volumio Keuken/Sílvia Pérez Cruz - Toda la vida, un día Hi-Res/Sílvia Pérez Cruz - Toda la vida, un día (2023) Hi-Res/01. Ell no vol que el món s'acabi (Mov.1 La Flor).flac","trackType":"flac"} Oct 29 08:36:51 primo volumio[1123]: verbose: CURRENT POSITION 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:51 primo volumio[1123]: info: ------------------------------ 51ms Oct 29 08:36:51 primo volumio[1123]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 29 08:36:51 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:51 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"983 Kbps","isStreaming":false,"title":"Ell no vol que el món s'acabi (Mov.1: La Flor)","artist":"Sílvia Pérez Cruz","album":"Toda la vida, un día","uri":"USB/E395-1170/Muziek Volumio Keuken/Sílvia Pérez Cruz - Toda la vida, un día Hi-Res/Sílvia Pérez Cruz - Toda la vida, un día (2023) Hi-Res/01. Ell no vol que el món s'acabi (Mov.1 La Flor).flac","trackType":"flac"} Oct 29 08:36:51 primo volumio[1123]: verbose: CURRENT POSITION 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:51 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:51 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:51 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:51 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:51 primo volumio[1123]: info: ------------------------------ 47ms Oct 29 08:36:51 primo volumio[1123]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 4501 Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:36:52 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:52 primo volumio[1123]: info: Oct 29 08:36:52 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand stop took 21 milliseconds Oct 29 08:36:52 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/2020 Entretiempo y Tiempo 24-48 FLAC/2020 Entretiempo y Tiempo 24-48 FLAC/03 Chorinho pra Jaques.flac Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand status took 5 milliseconds Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand stop took 3 milliseconds Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:36:52 primo volumio[1123]: info: Oct 29 08:36:52 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:52 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand playlistinfo took 17 milliseconds Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand clear took 17 milliseconds Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/2020 Entretiempo y Tiempo 24-48 FLAC/2020 Entretiempo y Tiempo 24-48 FLAC/03 Chorinho pra Jaques.flac" Oct 29 08:36:52 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: 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":"Ell no vol que el món s'acabi (Mov.1: La Flor)","artist":"Sílvia Pérez Cruz","album":"Toda la vida, un día","uri":"USB/E395-1170/Muziek Volumio Keuken/Sílvia Pérez Cruz - Toda la vida, un día Hi-Res/Sílvia Pérez Cruz - Toda la vida, un día (2023) Hi-Res/01. Ell no vol que el món s'acabi (Mov.1 La Flor).flac","trackType":"flac"} Oct 29 08:36:52 primo volumio[1123]: verbose: CURRENT POSITION 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: No code Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:52 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: ------------------------------ 97ms Oct 29 08:36:52 primo volumio[1123]: error: updateQueue error: null Oct 29 08:36:52 primo volumio[1123]: info: Oct 29 08:36:52 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:52 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:52 primo volumio[1123]: info: ------------------------------ 92ms Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/2020 Entretiempo y Tiempo 24-48 FLAC/2020 Entretiempo y Tiempo 24-48 FLAC/03 Chorinho pra Jaques.flac" took 91 milliseconds Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:36:52 primo volumio[1123]: info: Oct 29 08:36:52 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:52 primo volumio[1123]: info: ------------------------------ 70ms Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand play took 69 milliseconds Oct 29 08:36:52 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:52 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Oct 29 08:36:52 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 48000 Oct 29 08:36:52 primo volumio[1123]: info: camilladsp stopping service pid 26711... Oct 29 08:36:52 primo volumio[1123]: info: camilladsp service terminated, instance 1 Oct 29 08:36:52 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:52 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:52 primo volumio[1123]: info: camilladsp service started and running in background, instance 1 Oct 29 08:36:52 primo volumio[1123]: info: Oct 29 08:36:52 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:52 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand status took 77 milliseconds Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand status took 15 milliseconds Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:52 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1238,"duration":152,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Chorinho pra Jaques","artist":"Omar Acosta","album":"Entretiempo y Tiempo","uri":"USB/E395-1170/Muziek Volumio Keuken/2020 Entretiempo y Tiempo 24-48 FLAC/2020 Entretiempo y Tiempo 24-48 FLAC/03 Chorinho pra Jaques.flac","trackType":"flac"} Oct 29 08:36:52 primo volumio[1123]: verbose: CURRENT POSITION 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:52 primo volumio[1123]: info: ------------------------------ 108ms Oct 29 08:36:52 primo volumio[1123]: info: camilladsp spawned new process with pid 26739, instance 1, run: true Oct 29 08:36:52 primo volumio[1123]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 29 08:36:52 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:52 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":152,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1495 Kbps","isStreaming":false,"title":"Chorinho pra Jaques","artist":"Omar Acosta","album":"Entretiempo y Tiempo","uri":"USB/E395-1170/Muziek Volumio Keuken/2020 Entretiempo y Tiempo 24-48 FLAC/2020 Entretiempo y Tiempo 24-48 FLAC/03 Chorinho pra Jaques.flac","trackType":"flac"} Oct 29 08:36:52 primo volumio[1123]: verbose: CURRENT POSITION 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:52 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:52 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:52 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:52 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:53 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:53 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:53 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:53 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:53 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:53 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:53 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:53 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:53 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:53 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:53 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:53 primo volumio[1123]: info: ------------------------------ 163ms Oct 29 08:36:54 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:54 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:54 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:54 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:54 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:54 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 759 Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:36:55 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:55 primo volumio[1123]: info: Oct 29 08:36:55 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand stop took 26 milliseconds Oct 29 08:36:55 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/Joe Hisaishi Box/Studio Ghibli Hayao Miyazaki & Joe Hisaishi Soundtrack Box (2014, Flac)/CD 10/15 - Ponyo to Sousuke II.flac Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand stop took 5 milliseconds Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:36:55 primo volumio[1123]: info: Oct 29 08:36:55 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:55 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand clear took 9 milliseconds Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Joe Hisaishi Box/Studio Ghibli Hayao Miyazaki & Joe Hisaishi Soundtrack Box (2014, Flac)/CD 10/15 - Ponyo to Sousuke II.flac" Oct 29 08:36:55 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: 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":"Chorinho pra Jaques","artist":"Omar Acosta","album":"Entretiempo y Tiempo","uri":"USB/E395-1170/Muziek Volumio Keuken/2020 Entretiempo y Tiempo 24-48 FLAC/2020 Entretiempo y Tiempo 24-48 FLAC/03 Chorinho pra Jaques.flac","trackType":"flac"} Oct 29 08:36:55 primo volumio[1123]: verbose: CURRENT POSITION 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: No code Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: ------------------------------ 70ms Oct 29 08:36:55 primo volumio[1123]: error: updateQueue error: null Oct 29 08:36:55 primo volumio[1123]: info: Oct 29 08:36:55 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:36:55 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:36:55 primo volumio[1123]: info: ------------------------------ 53ms Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/Joe Hisaishi Box/Studio Ghibli Hayao Miyazaki & Joe Hisaishi Soundtrack Box (2014, Flac)/CD 10/15 - Ponyo to Sousuke II.flac" took 45 milliseconds Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:36:55 primo volumio[1123]: info: Oct 29 08:36:55 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:55 primo volumio[1123]: info: ------------------------------ 33ms Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand play took 32 milliseconds Oct 29 08:36:55 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:36:55 primo volumio[1123]: info: camilladsp stopping service pid 26739... Oct 29 08:36:55 primo volumio[1123]: info: camilladsp service terminated, instance 1 Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:55 primo volumio[1123]: info: camilladsp service started and running in background, instance 1 Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:36:55 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:36:55 primo volumio[1123]: info: Oct 29 08:36:55 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand status took 64 milliseconds Oct 29 08:36:55 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand status took 4 milliseconds Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:55 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"137 Kbps","isStreaming":false,"title":"Ponyo to Sousuke II","artist":"Jou Hisaishi","album":"Studio Ghibli \"Hayao Miyazaki & Jou Hisaishi\" Soundtrack BOX CD 10","uri":"USB/E395-1170/Muziek Volumio Keuken/Joe Hisaishi Box/Studio Ghibli Hayao Miyazaki & Joe Hisaishi Soundtrack Box (2014, Flac)/CD 10/15 - Ponyo to Sousuke II.flac","trackType":"flac"} Oct 29 08:36:55 primo volumio[1123]: verbose: CURRENT POSITION 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:36:55 primo volumio[1123]: info: ------------------------------ 75ms Oct 29 08:36:55 primo volumio[1123]: error: FusionDsp - WebSocket error: [object Object] Oct 29 08:36:55 primo volumio[1123]: info: camilladsp spawned new process with pid 26752, instance 1, run: true Oct 29 08:36:55 primo volumio[1123]: info: sendMpdCommand playlistinfo took 31 milliseconds Oct 29 08:36:55 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:55 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"Ponyo to Sousuke II","artist":"Jou Hisaishi","album":"Studio Ghibli \"Hayao Miyazaki & Jou Hisaishi\" Soundtrack BOX CD 10","uri":"USB/E395-1170/Muziek Volumio Keuken/Joe Hisaishi Box/Studio Ghibli Hayao Miyazaki & Joe Hisaishi Soundtrack Box (2014, Flac)/CD 10/15 - Ponyo to Sousuke II.flac","trackType":"flac"} Oct 29 08:36:55 primo volumio[1123]: verbose: CURRENT POSITION 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:36:55 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:55 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:55 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:55 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:55 primo volumio[1123]: info: ------------------------------ 66ms Oct 29 08:36:57 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:57 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::volumioPause Oct 29 08:36:57 primo volumio[1123]: info: CoreStateMachine::pause Oct 29 08:36:57 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:57 primo volumio[1123]: info: CoreStateMachine::servicePause Oct 29 08:36:57 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::servicePause Oct 29 08:36:57 primo volumio[1123]: info: ControllerMpd::pause Oct 29 08:36:57 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand pause Oct 29 08:36:57 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:36:57 primo volumio[1123]: info: Oct 29 08:36:57 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:36:57 primo volumio[1123]: info: sendMpdCommand pause took 6 milliseconds Oct 29 08:36:57 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:36:57 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:36:57 primo volumio[1123]: info: sendMpdCommand status took 0 milliseconds Oct 29 08:36:57 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:36:57 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:36:57 primo volumio[1123]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:36:57 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:36:57 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:36:57 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:57 primo volumio[1123]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4095,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"882 Kbps","isStreaming":false,"title":"Ponyo to Sousuke II","artist":"Jou Hisaishi","album":"Studio Ghibli \"Hayao Miyazaki & Jou Hisaishi\" Soundtrack BOX CD 10","uri":"USB/E395-1170/Muziek Volumio Keuken/Joe Hisaishi Box/Studio Ghibli Hayao Miyazaki & Joe Hisaishi Soundtrack Box (2014, Flac)/CD 10/15 - Ponyo to Sousuke II.flac","trackType":"flac"} Oct 29 08:36:57 primo volumio[1123]: verbose: CURRENT POSITION 3001 Oct 29 08:36:57 primo volumio[1123]: info: CoreStateMachine::syncState stateService pause Oct 29 08:36:57 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus pause Oct 29 08:36:57 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:36:57 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:36:57 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:36:57 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:36:57 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:36:57 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:36:57 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:36:57 primo volumio[1123]: info: ------------------------------ 19ms Oct 29 08:36:57 primo volumio[1123]: info: camilladsp spawned new process with pid 26759, instance 1, run: true Oct 29 08:37:00 primo volumio[1123]: info: CoreCommandRouter::volumioGetQueue Oct 29 08:37:00 primo volumio[1123]: info: CoreStateMachine::getQueue Oct 29 08:37:00 primo volumio[1123]: info: CorePlayQueue::getQueue Oct 29 08:37:03 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 29 08:37:03 primo volumio[1123]: info: CURURI: artists:// Oct 29 08:37:03 primo volumio[1123]: info: Preload queue cleared Oct 29 08:37:10 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 29 08:37:10 primo volumio[1123]: info: CURURI: artists:// Oct 29 08:37:10 primo volumio[1123]: info: Preload queue cleared Oct 29 08:37:16 primo volumio[1123]: info: Preload queue cleared Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::ClearQueue Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 3001 Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:37:16 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::clearPlayQueue Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::saveQueue Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushQueue Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::addQueueItems Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::addQueueItems Oct 29 08:37:16 primo volumio[1123]: info: Preload queue cleared Oct 29 08:37:16 primo volumio[1123]: info: Adding Item to queue: artists://Alessandra%20Ziveri Oct 29 08:37:16 primo volumio[1123]: info: Exploding uri artists://Alessandra%20Ziveri in service mpd Oct 29 08:37:16 primo volumio[1123]: info: Oct 29 08:37:16 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand stop took 35 milliseconds Oct 29 08:37:16 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushQueue Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::saveQueue Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPlay Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::play index 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand status took 34 milliseconds Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand stop took 8 milliseconds Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:37:16 primo volumio[1123]: info: Oct 29 08:37:16 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:37:16 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand clear took 3 milliseconds Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac" Oct 29 08:37:16 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: 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":"Ponyo to Sousuke II","artist":"Jou Hisaishi","album":"Studio Ghibli \"Hayao Miyazaki & Jou Hisaishi\" Soundtrack BOX CD 10","uri":"USB/E395-1170/Muziek Volumio Keuken/Joe Hisaishi Box/Studio Ghibli Hayao Miyazaki & Joe Hisaishi Soundtrack Box (2014, Flac)/CD 10/15 - Ponyo to Sousuke II.flac","trackType":"flac"} Oct 29 08:37:16 primo volumio[1123]: verbose: CURRENT POSITION 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: No code Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: ------------------------------ 79ms Oct 29 08:37:16 primo volumio[1123]: error: updateQueue error: null Oct 29 08:37:16 primo volumio[1123]: info: Oct 29 08:37:16 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:37:16 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:37:16 primo volumio[1123]: info: ------------------------------ 55ms Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac" took 54 milliseconds Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:37:16 primo volumio[1123]: info: Oct 29 08:37:16 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:16 primo volumio[1123]: info: ------------------------------ 52ms Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand play took 49 milliseconds Oct 29 08:37:16 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:16 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:37:16 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:37:16 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:37:16 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:37:16 primo volumio[1123]: info: Oct 29 08:37:16 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:16 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand status took 21 milliseconds Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand status took 10 milliseconds Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:16 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":526,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"270 Kbps","isStreaming":false,"title":"Rapsodie","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac","trackType":"flac"} Oct 29 08:37:16 primo volumio[1123]: verbose: CURRENT POSITION 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:37:16 primo volumio[1123]: info: ------------------------------ 36ms Oct 29 08:37:16 primo volumio[1123]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 29 08:37:16 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:16 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":526,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"270 Kbps","isStreaming":false,"title":"Rapsodie","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac","trackType":"flac"} Oct 29 08:37:16 primo volumio[1123]: verbose: CURRENT POSITION 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:37:16 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:16 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:16 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:16 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:16 primo volumio[1123]: info: ------------------------------ 50ms Oct 29 08:37:16 primo volumio[1123]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 08:37:18 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:37:18 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:37:18 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:37:18 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:37:18 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:37:18 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:37:18 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:37:18 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:37:18 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:37:18 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:18 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:18 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::volumioSeek Oct 29 08:37:28 primo volumio[1123]: info: CoreStateMachine::seek Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: info: TRACKBLOCK {"uri":"music-library/USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac","service":"mpd","name":"Rapsodie","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=613&web=Alessandra%20Ziveri/Germaine%20Tailleferre%2C%20Louise%20Charpentier%2C%20Ren%C3%A9e%20Hansen-Jamet%3A%20La%20promenade%20des%20dames/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FLa%20promenade%20des%20dames%20FLAC%2FAlessandra%20Ziveri%20-%20Germaine%20Tailleferre%2C%20Louise%20Charpentier%2C%20Ren%C3%A9e%20Hansen-Jamet_%20La%20promenade%20des%20dames%20(2019)%20FLAC&metadata=false","duration":526,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Oct 29 08:37:28 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: info: ControllerMpd::seek Oct 29 08:37:28 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:28 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:28 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: error: null Oct 29 08:37:28 primo volumio[1123]: info: Oct 29 08:37:28 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:28 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:28 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:28 primo volumio[1123]: info: sendMpdCommand status took 9 milliseconds Oct 29 08:37:28 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:28 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:28 primo volumio[1123]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:37:28 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:28 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":186212,"duration":526,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"399 Kbps","isStreaming":false,"title":"Rapsodie","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac","trackType":"flac"} Oct 29 08:37:28 primo volumio[1123]: verbose: CURRENT POSITION 0 Oct 29 08:37:28 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:37:28 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:37:28 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:37:28 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:28 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:28 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:28 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:28 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:28 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:28 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:28 primo volumio[1123]: info: ------------------------------ 45ms Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioNext Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::next Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::stop Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::serviceStop Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::serviceStop Oct 29 08:37:32 primo volumio[1123]: info: ControllerMpd::stop Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:37:32 primo volumio[1123]: info: Oct 29 08:37:32 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand stop took 21 milliseconds Oct 29 08:37:32 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::play index undefined Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::clearAddPlayTracks USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand status took 3 milliseconds Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand stop took 2 milliseconds Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 08:37:32 primo volumio[1123]: info: Oct 29 08:37:32 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:37:32 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand clear took 10 milliseconds Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac" Oct 29 08:37:32 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: 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":"Rapsodie","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/01. Rapsodie.flac","trackType":"flac"} Oct 29 08:37:32 primo volumio[1123]: verbose: CURRENT POSITION 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: No code Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: ------------------------------ 75ms Oct 29 08:37:32 primo volumio[1123]: error: updateQueue error: null Oct 29 08:37:32 primo volumio[1123]: info: Oct 29 08:37:32 primo volumio[1123]: ---------------------------- MPD announces system playlist update Oct 29 08:37:32 primo volumio[1123]: info: Ignoring MPD Status Update Oct 29 08:37:32 primo volumio[1123]: info: ------------------------------ 68ms Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand add "USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac" took 67 milliseconds Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand play Oct 29 08:37:32 primo volumio[1123]: info: Oct 29 08:37:32 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:32 primo volumio[1123]: info: ------------------------------ 29ms Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand play took 27 milliseconds Oct 29 08:37:32 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:32 primo volumio[1123]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 29 08:37:32 primo volumio[1123]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 29 08:37:32 primo volumio[1123]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 29 08:37:32 primo volumio[1123]: info: FusionDsp - Effects disabled Oct 29 08:37:32 primo volumio[1123]: info: Oct 29 08:37:32 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:32 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand status took 14 milliseconds Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand status took 13 milliseconds Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:32 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":86,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"373 Kbps","isStreaming":false,"title":"Le petit livre de harpe de Madame Tardieu: No. 17, Ondine","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac","trackType":"flac"} Oct 29 08:37:32 primo volumio[1123]: verbose: CURRENT POSITION 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 29 08:37:32 primo volumio[1123]: info: ------------------------------ 30ms Oct 29 08:37:32 primo volumio[1123]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 29 08:37:32 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:32 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":86,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"373 Kbps","isStreaming":false,"title":"Le petit livre de harpe de Madame Tardieu: No. 17, Ondine","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac","trackType":"flac"} Oct 29 08:37:32 primo volumio[1123]: verbose: CURRENT POSITION 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:37:32 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:32 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:32 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:32 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:32 primo volumio[1123]: info: ------------------------------ 52ms Oct 29 08:37:32 primo volumio[1123]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::volumioSeek Oct 29 08:37:34 primo volumio[1123]: info: CoreStateMachine::seek Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: info: TRACKBLOCK {"uri":"music-library/USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac","service":"mpd","name":"Le petit livre de harpe de Madame Tardieu: No. 17, Ondine","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=613&web=Alessandra%20Ziveri/Germaine%20Tailleferre%2C%20Louise%20Charpentier%2C%20Ren%C3%A9e%20Hansen-Jamet%3A%20La%20promenade%20des%20dames/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FLa%20promenade%20des%20dames%20FLAC%2FAlessandra%20Ziveri%20-%20Germaine%20Tailleferre%2C%20Louise%20Charpentier%2C%20Ren%C3%A9e%20Hansen-Jamet_%20La%20promenade%20des%20dames%20(2019)%20FLAC&metadata=false","duration":86,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Oct 29 08:37:34 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: info: ControllerMpd::seek Oct 29 08:37:34 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:34 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:34 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: error: null Oct 29 08:37:34 primo volumio[1123]: info: Oct 29 08:37:34 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:34 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:34 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:34 primo volumio[1123]: info: sendMpdCommand status took 1 milliseconds Oct 29 08:37:34 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:34 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:34 primo volumio[1123]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 29 08:37:34 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:34 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32212,"duration":86,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"576 Kbps","isStreaming":false,"title":"Le petit livre de harpe de Madame Tardieu: No. 17, Ondine","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac","trackType":"flac"} Oct 29 08:37:34 primo volumio[1123]: verbose: CURRENT POSITION 17 Oct 29 08:37:34 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:37:34 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:37:34 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:37:34 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:34 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:34 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:34 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:34 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:34 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:34 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:34 primo volumio[1123]: info: ------------------------------ 30ms Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::volumioSeek Oct 29 08:37:35 primo volumio[1123]: info: CoreStateMachine::seek Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: info: TRACKBLOCK {"uri":"music-library/USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac","service":"mpd","name":"Le petit livre de harpe de Madame Tardieu: No. 17, Ondine","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=613&web=Alessandra%20Ziveri/Germaine%20Tailleferre%2C%20Louise%20Charpentier%2C%20Ren%C3%A9e%20Hansen-Jamet%3A%20La%20promenade%20des%20dames/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FLa%20promenade%20des%20dames%20FLAC%2FAlessandra%20Ziveri%20-%20Germaine%20Tailleferre%2C%20Louise%20Charpentier%2C%20Ren%C3%A9e%20Hansen-Jamet_%20La%20promenade%20des%20dames%20(2019)%20FLAC&metadata=false","duration":86,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Oct 29 08:37:35 primo volumio[1123]: info: CoreStateMachine::startPlaybackTimer Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: info: ControllerMpd::seek Oct 29 08:37:35 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:35 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:35 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: error: null Oct 29 08:37:35 primo volumio[1123]: info: Oct 29 08:37:35 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:35 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:35 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:35 primo volumio[1123]: info: sendMpdCommand status took 9 milliseconds Oct 29 08:37:35 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:35 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:35 primo volumio[1123]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 08:37:35 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:35 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46212,"duration":86,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"501 Kbps","isStreaming":false,"title":"Le petit livre de harpe de Madame Tardieu: No. 17, Ondine","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac","trackType":"flac"} Oct 29 08:37:35 primo volumio[1123]: verbose: CURRENT POSITION 17 Oct 29 08:37:35 primo volumio[1123]: info: CoreStateMachine::syncState stateService play Oct 29 08:37:35 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus play Oct 29 08:37:35 primo volumio[1123]: info: Received an update from plugin. extracting info from payload Oct 29 08:37:35 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:35 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:35 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:35 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:35 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:35 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:35 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:35 primo volumio[1123]: info: ------------------------------ 40ms Oct 29 08:37:37 primo volumio[1123]: info: CoreCommandRouter::volumioPause Oct 29 08:37:37 primo volumio[1123]: info: CoreStateMachine::pause Oct 29 08:37:37 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:37:37 primo volumio[1123]: info: CoreStateMachine::servicePause Oct 29 08:37:37 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:37 primo volumio[1123]: info: CoreCommandRouter::servicePause Oct 29 08:37:37 primo volumio[1123]: info: ControllerMpd::pause Oct 29 08:37:37 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand pause Oct 29 08:37:37 primo volumio[1123]: info: Oct 29 08:37:37 primo volumio[1123]: ---------------------------- MPD announces state update: player Oct 29 08:37:37 primo volumio[1123]: info: sendMpdCommand pause took 2 milliseconds Oct 29 08:37:37 primo volumio[1123]: info: ControllerMpd::getState Oct 29 08:37:37 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 29 08:37:37 primo volumio[1123]: info: sendMpdCommand status took 1 milliseconds Oct 29 08:37:37 primo volumio[1123]: verbose: ControllerMpd::parseState Oct 29 08:37:37 primo volumio[1123]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 08:37:37 primo volumio[1123]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 08:37:37 primo volumio[1123]: verbose: ControllerMpd::parseTrackInfo Oct 29 08:37:37 primo volumio[1123]: info: ControllerMpd::pushState Oct 29 08:37:37 primo volumio[1123]: info: CoreCommandRouter::servicePushState Oct 29 08:37:37 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:37 primo volumio[1123]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":47974,"duration":86,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"422 Kbps","isStreaming":false,"title":"Le petit livre de harpe de Madame Tardieu: No. 17, Ondine","artist":"Alessandra Ziveri","album":"Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet: La promenade des dames","uri":"USB/E395-1170/Muziek Volumio Keuken/La promenade des dames FLAC/Alessandra Ziveri - Germaine Tailleferre, Louise Charpentier, Renée Hansen-Jamet_ La promenade des dames (2019) FLAC/18. Le petit livre de harpe de Madame Tardieu_ No. 17, Ondine.flac","trackType":"flac"} Oct 29 08:37:37 primo volumio[1123]: verbose: CURRENT POSITION 17 Oct 29 08:37:37 primo volumio[1123]: info: CoreStateMachine::syncState stateService pause Oct 29 08:37:37 primo volumio[1123]: info: CoreStateMachine::syncState currentStatus pause Oct 29 08:37:37 primo volumio[1123]: info: CoreStateMachine::pushState Oct 29 08:37:37 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:37 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 08:37:37 primo volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 29 08:37:37 primo volumio[1123]: info: MRS: Pushing multiroomSync output update for this device Oct 29 08:37:37 primo volumio[1123]: info: MRS: Pushing multiroomSync output Oct 29 08:37:37 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:37 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:37 primo volumio[1123]: info: CoreStateMachine::stPlaybackTimer Oct 29 08:37:37 primo volumio[1123]: info: ------------------------------ 17ms Oct 29 08:37:37 primo volumio[1123]: info: camilladsp spawned new process with pid 26834, instance 1, run: true Oct 29 08:37:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 29 08:37:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 29 08:37:48 primo volumio[1123]: info: Discovery: Getting this device information Oct 29 08:37:48 primo volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 29 08:37:48 primo volumio[1123]: info: CorePlayQueue::getTrack 17 Oct 29 08:37:48 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 29 08:37:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 29 08:37:52 primo volumio[1123]: info: CURURI: artists://Chicago%20Symphony%20Orchestra%20(CSO) Oct 29 08:37:52 primo volumio[1123]: info: Preload queue cleared Oct 29 08:37:52 primo volumio[1123]: info: Preload queue cleared Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/01 - 1. Mars, The Bringer Of War.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/02 - 2. Venus, The Bringer Of Peace.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/03 - 3. Mercury, The Winged Messenge.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/04 - 4. Jupiter, The Bringer Of Joll.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/05 - 5. Saturn, The Bringer Of Old A.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/06 - 6. Uranus, The Magician.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/07 - 7. Neptune, The Mystic.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/08 - Vaughan Williams_ Fantasia On G.flac Oct 29 08:37:52 primo volumio[1123]: info: Preloading song: music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/09 - Largo sostenuto.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/01 - 1. Mars, The Bringer Of War.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F01%20-%201.%20Mars%2C%20The%20Bringer%20Of%20War.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/01 - 1. Mars, The Bringer Of War.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/02 - 2. Venus, The Bringer Of Peace.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: Executing endpoint getSimilarArtists Oct 29 08:37:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Oct 29 08:37:52 primo volumio[1123]: info: Executing endpoint getSimilarArtists Oct 29 08:37:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F02%20-%202.%20Venus%2C%20The%20Bringer%20Of%20Peace.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/02 - 2. Venus, The Bringer Of Peace.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/03 - 3. Mercury, The Winged Messenge.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F03%20-%203.%20Mercury%2C%20The%20Winged%20Messenge.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/03 - 3. Mercury, The Winged Messenge.flac Oct 29 08:37:52 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:37:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:37:52 primo volumio[1123]: info: Executing endpoint metavolumio Oct 29 08:37:52 primo volumio[1123]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/04 - 4. Jupiter, The Bringer Of Joll.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F04%20-%204.%20Jupiter%2C%20The%20Bringer%20Of%20Joll.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/04 - 4. Jupiter, The Bringer Of Joll.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/05 - 5. Saturn, The Bringer Of Old A.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F05%20-%205.%20Saturn%2C%20The%20Bringer%20Of%20Old%20A.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/05 - 5. Saturn, The Bringer Of Old A.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/06 - 6. Uranus, The Magician.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F06%20-%206.%20Uranus%2C%20The%20Magician.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/06 - 6. Uranus, The Magician.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/07 - 7. Neptune, The Mystic.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F07%20-%207.%20Neptune%2C%20The%20Mystic.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/07 - 7. Neptune, The Mystic.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/08 - Vaughan Williams_ Fantasia On G.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F08%20-%20Vaughan%20Williams_%20Fantasia%20On%20G.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/08 - Vaughan Williams_ Fantasia On G.flac Oct 29 08:37:52 primo volumio[1123]: info: Exploding uri music-library/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/09 - Largo sostenuto.flac in service mpd Oct 29 08:37:52 primo volumio[1123]: info: ALBUMART /albumart?cacheid=613&web=/Gustav%20Holst%20%3A%20The%20Planets%20%2F%20Ralph%20Vaughan%20Williams%20%3A%20Fantasia%20on%20Greensleeves%3B%20Fantasia%20on%20a%20Theme%20by%20Thomas%20Fallis/extralarge&path=%2Fmnt%2FUSB%2FE395-1170%2FMuziek%20Volumio%20Keuken%2FJames%20Levine%20Gustav%20Holst%20The%20Planets%2004%202410%2FChicago%20Symphony%20Orchestra%2C%20James%20Levine%20-%20Gustav%20Holst%20The%20Planets%20(2004)%20FLAC%20(16bit-44.1kHz)%2F09%20-%20Largo%20sostenuto.flac&metadata=false Oct 29 08:37:52 primo volumio[1123]: info: URI /mnt/USB/E395-1170/Muziek Volumio Keuken/James Levine Gustav Holst The Planets 04 2410/Chicago Symphony Orchestra, James Levine - Gustav Holst The Planets (2004) FLAC (16bit-44.1kHz)/09 - Largo sostenuto.flac Oct 29 08:37:56 primo volumio[1123]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 08:37:56 primo volumio[1123]: TypeError: Cannot read property 'slice' of null Oct 29 08:37:56 primo volumio[1123]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Oct 29 08:37:56 primo volumio[1123]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Oct 29 08:37:56 primo volumio[1123]: at Object.onceWrapper (events.js:520:26) Oct 29 08:37:56 primo volumio[1123]: at ClientRequest.emit (events.js:400:28) Oct 29 08:37:56 primo volumio[1123]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Oct 29 08:37:56 primo volumio[1123]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Oct 29 08:37:56 primo volumio[1123]: at TLSSocket.socketOnData (_http_client.js:515:22) Oct 29 08:37:56 primo volumio[1123]: at TLSSocket.emit (events.js:400:28) Oct 29 08:37:56 primo volumio[1123]: at addChunk (internal/streams/readable.js:293:12) Oct 29 08:37:56 primo volumio[1123]: at readableAddChunk (internal/streams/readable.js:267:9) Oct 29 08:37:56 primo volumio[1123]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Oct 29 08:37:56 primo volumio[1123]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Oct 29 08:37:56 primo volumio[1123]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 08:37:56 primo sudo[26923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-29 08:36 Oct 29 08:37:56 primo sudo[26923]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:55:15 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="2f3686ade78abf3b92c180a0c5b20c6b"