-- Logs begin at Sat 2025-01-18 21:13:22 +07, end at Sat 2025-01-18 21:15:10 +07. -- Jan 18 21:14:00 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jan 18 21:14:01 volumio volumio[672]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 16 Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:02 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 18 21:14:02 volumio volumio[672]: info: Received Get System Info Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 21:14:02 volumio volumio[672]: info: Discovery: Getting this device information Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:02 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:02 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:02 volumio volumio[672]: info: Listing playlists Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 21:14:02 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 18 21:14:02 volumio volumio[1019]: ........................................................................++++ Jan 18 21:14:02 volumio volumio[1019]: e is 65537 (0x010001) Jan 18 21:14:02 volumio volumio[1019]: writing RSA key Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 18 21:14:03 volumio volumio[672]: info: Received Get System Info Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 21:14:03 volumio volumio[672]: info: Discovery: Getting this device information Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 21:14:03 volumio volumio[672]: info: AutoStart - Plugin is starting Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::volumioGetQueue Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::getQueue Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getQueue Jan 18 21:14:03 volumio volumio[672]: info: AutoStart - start playing Jan 18 21:14:03 volumio volumio[672]: info: AutoStart - start playing with no specific position Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::volumioPlay Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::play index 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::stop Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::play index undefined Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::startPlaybackTimer Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand stop took 1 milliseconds Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand clear Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand clear took 1 milliseconds Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac" Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand add "NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac" took 6 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: ------------------------------ 5ms Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand play Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio volumio[672]: info: ------------------------------ 13ms Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand play took 8 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: ------------------------------ 6ms Jan 18 21:14:03 volumio volumio[672]: info: ------------------------------ 5ms Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:14:03 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:14:03 volumio kernel: CIFS: __readahead_batch() returned 1/15 Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: info: ------------------------------ 11ms Jan 18 21:14:03 volumio volumio[672]: info: ------------------------------ 10ms Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: info: FusionDsp - ---- read samplerate, raw: Jan 18 21:14:03 volumio volumio[672]: error: FusionDsp - invalid sample rate Jan 18 21:14:03 volumio volumio[672]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Jan 18 21:14:03 volumio volumio[672]: info: FusionDsp - ---- read samplerate from file: 48000 Jan 18 21:14:03 volumio volumio[672]: info: camilladsp stopping service pid 958... Jan 18 21:14:03 volumio volumio[672]: info: camilladsp service terminated, instance 1 Jan 18 21:14:03 volumio volumio[672]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 21:14:03 volumio volumio[672]: info: camilladsp service started and running in background, instance 1 Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 77 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 77 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 78 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 77 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: info: Jan 18 21:14:03 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 44 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand playlistinfo took 47 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand playlistinfo took 48 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand playlistinfo took 48 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand playlistinfo took 48 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 34 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 30 milliseconds Jan 18 21:14:03 volumio volumio[672]: info: sendMpdCommand status took 28 milliseconds Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:03 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:03 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus stop Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:03 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:14:03 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:03 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:03 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:14:03 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:03 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:03 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:03 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:04 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:14:04 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 193ms Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 339ms Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 339ms Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 338ms Jan 18 21:14:04 volumio volumio[672]: info: camilladsp spawned new process with pid 1350, instance 1, run: true Jan 18 21:14:04 volumio volumio[672]: info: sendMpdCommand playlistinfo took 254 milliseconds Jan 18 21:14:04 volumio volumio[672]: info: sendMpdCommand playlistinfo took 251 milliseconds Jan 18 21:14:04 volumio volumio[672]: info: sendMpdCommand playlistinfo took 251 milliseconds Jan 18 21:14:04 volumio volumio[672]: info: sendMpdCommand playlistinfo took 251 milliseconds Jan 18 21:14:04 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:04 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:04 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:04 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:14:04 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1399 Kbps","isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:04 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:14:04 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1399 Kbps","isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:04 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:14:04 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1399 Kbps","isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:04 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:14:04 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":224,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1399 Kbps","isStreaming":false,"title":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:14:04 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:14:04 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:04 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 499ms Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 478ms Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 475ms Jan 18 21:14:04 volumio volumio[672]: info: ------------------------------ 473ms Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Handling event: musicPlay Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:04 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:05 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:05 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:05 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:05 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:05 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:06 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:06 volumio volumio[672]: info: CoreCommandRouter::Close All Modals sent Jan 18 21:14:10 volumio volumio[672]: info: Disabling plugin rotaryencoder2 Jan 18 21:14:10 volumio volumio[672]: info: Done. Jan 18 21:14:11 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:11 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:11 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:11 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:11 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:11 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:12 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:12 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:12 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 21:14:12 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:12 volumio volumio[672]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 17 Jan 18 21:14:12 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:12 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:14 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 21:14:14 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 21:14:14 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 21:14:14 volumio volumio-remote-updater[495]: No test mode Jan 18 21:14:14 volumio volumio-remote-updater[495]: No alpha test mode Jan 18 21:14:14 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 18 21:14:14 volumio volumio[672]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

 

NEW ADDITIONS

 

","title":"Update v3.785","updateavailable":true} Jan 18 21:14:14 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 18 21:14:15 volumio volumio[672]: info: [GPIO_Control] GPIOs destroyed Jan 18 21:14:15 volumio volumio[672]: info: Disabling plugin gpio_control Jan 18 21:14:15 volumio volumio[672]: info: Done. Jan 18 21:14:15 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:15 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:15 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:15 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:15 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:15 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:16 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:16 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:16 volumio volumio[672]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::volumioGetBrowseSources Jan 18 21:14:17 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 21:14:18 volumio volumio[672]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jan 18 21:14:18 volumio volumio[672]: info: Completed starting MyVolumio Plugin Jan 18 21:14:18 volumio volumio[672]: info: BOOT COMPLETED Jan 18 21:14:18 volumio volumio[672]: [Metrics] CommandRouter: 44s 500.54ms Jan 18 21:14:18 volumio volumio[672]: info: CoreCommandRouter::volumiosetStartupVolume Jan 18 21:14:18 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 21:14:18 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 21:14:18 volumio volumio[672]: info: CoreCommandRouter::Close All Modals sent Jan 18 21:14:18 volumio volumio[672]: info: CoreCommandRouter::Close All Modals sent Jan 18 21:14:18 volumio volumio[672]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 18 21:14:18 volumio volumio[672]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 18 21:14:18 volumio volumio[672]: info: camilladsp stopping service pid 1350... Jan 18 21:14:18 volumio volumio[672]: info: camilladsp service terminated, instance 1 Jan 18 21:14:18 volumio volumio[672]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 21:14:18 volumio volumio[672]: info: camilladsp service started and running in background, instance 1 Jan 18 21:14:18 volumio volumio[672]: info: camilladsp spawned new process with pid 1395, instance 1, run: true Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 21:14:19 volumio volumio[672]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 18 21:14:19 volumio volumio[672]: info: Received Get System Version Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 21:14:19 volumio volumio[672]: info: Received Get System Info Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 21:14:19 volumio volumio[672]: info: Discovery: Getting this device information Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:19 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 21:14:19 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 18 21:14:28 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:28 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:30 volumio volumio[672]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 18 Jan 18 21:14:30 volumio volumio[672]: info: CoreCommandRouter::volumioGetState Jan 18 21:14:30 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:30 volumio kernel: CIFS: __readahead_batch() returned 1/15 Jan 18 21:14:34 volumio ntpd[622]: Soliciting pool server 151.0.2.53 Jan 18 21:14:35 volumio ntpd[622]: Soliciting pool server 5.188.119.216 Jan 18 21:14:36 volumio ntpd[622]: Soliciting pool server 45.92.177.52 Jan 18 21:14:37 volumio ntpd[622]: Soliciting pool server 89.110.95.134 Jan 18 21:14:37 volumio ntpd[622]: Soliciting pool server 193.106.93.116 Jan 18 21:14:38 volumio ntpd[622]: Soliciting pool server 195.218.227.230 Jan 18 21:14:38 volumio ntpd[622]: Soliciting pool server 192.36.143.130 Jan 18 21:14:38 volumio ntpd[622]: Soliciting pool server 185.211.244.47 Jan 18 21:14:38 volumio ntpd[622]: Soliciting pool server 195.90.182.235 Jan 18 21:14:39 volumio ntpd[622]: Soliciting pool server 151.0.2.54 Jan 18 21:14:40 volumio ntpd[622]: Soliciting pool server 93.95.100.85 Jan 18 21:14:41 volumio ntpd[622]: Soliciting pool server 2a01:230:2::a5 Jan 18 21:14:42 volumio volumio[672]: info: Preload queue cleared Jan 18 21:14:42 volumio volumio[672]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::ClearQueue Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::stop Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::stPlaybackTimer Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::updateTrackBlock Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::getTrackBlock Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:42 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 21:14:42 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::serviceStop Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:42 volumio volumio[672]: info: CoreCommandRouter::serviceStop Jan 18 21:14:42 volumio volumio[672]: info: ControllerMpd::stop Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::clearPlayQueue Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::saveQueue Jan 18 21:14:42 volumio volumio[672]: info: CoreCommandRouter::volumioPushQueue Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::addQueueItems Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::addQueueItems Jan 18 21:14:42 volumio volumio[672]: info: Preload queue cleared Jan 18 21:14:42 volumio volumio[672]: info: Adding Item to queue: music-library/NAS/Music/Yello/2009 - Touch Yello (Deluxe) Jan 18 21:14:42 volumio volumio[672]: info: Exploding uri music-library/NAS/Music/Yello/2009 - Touch Yello (Deluxe) in service mpd Jan 18 21:14:42 volumio volumio[672]: info: [GPIO_Control] Status changed: stop Jan 18 21:14:42 volumio volumio[672]: info: [GPIO_Control] Handling event: musicStop Jan 18 21:14:42 volumio volumio[672]: info: Jan 18 21:14:42 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F01%20-%20The%20Expert.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F02%20-%20You%20Better%20Hide%20Feat.%20Heidi%20Happy.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/02 - You Better Hide Feat. Heidi Happy.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F03%20-%20Out%20Of%20Dawn.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/03 - Out Of Dawn.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F04%20-%20Bostich%20(Reflected).flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/04 - Bostich (Reflected).flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F05%20-%20Till%20Tomorrow%20Feat.%20Till%20Broenner.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/05 - Till Tomorrow Feat. Till Broenner.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F06%20-%20Tangier%20Blue.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/06 - Tangier Blue.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F07%20-%20Part%20Love.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/07 - Part Love.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F08%20-%20Friday%20Smile.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/08 - Friday Smile.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F09%20-%20Kiss%20In%20Blue%20Feat.%20Heidi%20Happy.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/09 - Kiss In Blue Feat. Heidi Happy.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F10%20-%20Vertical%20Vision%20Feat.%20Till%20Broenner.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/10 - Vertical Vision Feat. Till Broenner.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F11%20-%20Trackless%20Deep.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/11 - Trackless Deep.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F12%20-%20Stay%20Feat.%20Heidi%20Happy.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/12 - Stay Feat. Heidi Happy.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F13%20-%20Electric%20Frame%20Feat.%20Till%20Broenner.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/13 - Electric Frame Feat. Till Broenner.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F14%20-%20Takla%20Makan%20Feat.%20Dorothee%20Oberlinger.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/14 - Takla Makan Feat. Dorothee Oberlinger.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F15%20-%20X-Race.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/15 - X-Race.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F16%20-%20Petro%20Oleum.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/16 - Petro Oleum.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F17%20-%20Oh%20Yeah%202009.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/17 - Oh Yeah 2009.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F18%20-%20Umbria.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/18 - Umbria.flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F19%20-%20Bostich%20(Duck%20Mobile).flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/19 - Bostich (Duck Mobile).flac Jan 18 21:14:42 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Yello/Touch%20Yello%20(Deluxe)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2009%20-%20Touch%20Yello%20(Deluxe)%2F20%20-%20Scorpio%20Rising.flac&metadata=false Jan 18 21:14:42 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2009 - Touch Yello (Deluxe)/20 - Scorpio Rising.flac Jan 18 21:14:42 volumio volumio[672]: info: sendMpdCommand stop took 143 milliseconds Jan 18 21:14:42 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:42 volumio volumio[672]: info: CoreCommandRouter::volumioPushQueue Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::saveQueue Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::updateTrackBlock Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::getTrackBlock Jan 18 21:14:42 volumio volumio[672]: info: CoreCommandRouter::volumioPlay Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::play index 0 Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::stop Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::play index undefined Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:42 volumio volumio[672]: info: CoreStateMachine::startPlaybackTimer Jan 18 21:14:42 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 21:14:42 volumio volumio[672]: info: Jan 18 21:14:42 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:42 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:42 volumio volumio[672]: info: Jan 18 21:14:42 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:42 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:42 volumio volumio[672]: info: Jan 18 21:14:42 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:14:42 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:14:42 volumio volumio[672]: info: sendMpdCommand status took 42 milliseconds Jan 18 21:14:42 volumio volumio[672]: info: sendMpdCommand stop took 14 milliseconds Jan 18 21:14:42 volumio volumio[672]: info: sendMpdCommand status took 10 milliseconds Jan 18 21:14:42 volumio volumio[672]: info: sendMpdCommand status took 7 milliseconds Jan 18 21:14:42 volumio volumio[672]: info: sendMpdCommand status took 7 milliseconds Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand clear Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:14:42 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 22133 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand clear took 22134 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 22134 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 22133 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 22131 milliseconds Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac" Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: 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":"Vertigo Heroes (Part I)","artist":"Boris Blank","album":"Resonance","uri":"NAS/Music/Yello/2024 - Boris Blank - Resonance/01 - Vertigo Heroes (Part I).flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService stop Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus stop Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: No code Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 18 21:15:05 volumio volumio[672]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 18 21:15:05 volumio volumio[672]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 22238ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 22183ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 22178ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 22178ms Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: error: updateQueue error: null Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 115ms Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand add "NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac" took 112 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 25ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 25ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 24ms Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand play Jan 18 21:15:05 volumio kernel: CIFS: __readahead_batch() returned 1/15 Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces system playlist update Jan 18 21:15:05 volumio volumio[672]: info: Ignoring MPD Status Update Jan 18 21:15:05 volumio volumio[672]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 150ms Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand play took 142 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 120ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 119ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 111ms Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 18 21:15:05 volumio volumio[672]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 18 21:15:05 volumio volumio[672]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 31 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 30 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 22 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 21 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 21 milliseconds Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: Jan 18 21:15:05 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::getState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand status Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 83 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 82 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 83 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 83 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 82 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 9 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 7 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand status took 7 milliseconds Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseState Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"819 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus stop Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"819 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:15:05 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"819 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:15:05 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"819 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:15:05 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"819 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:15:05 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 177ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 312ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 304ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 306ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 306ms Jan 18 21:15:05 volumio volumio[672]: info: [GPIO_Control] Status changed: stop Jan 18 21:15:05 volumio volumio[672]: info: [GPIO_Control] Status changed: stop Jan 18 21:15:05 volumio volumio[672]: info: [GPIO_Control] Status changed: stop Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 242 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 244 milliseconds Jan 18 21:15:05 volumio volumio[672]: info: sendMpdCommand playlistinfo took 244 milliseconds Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: verbose: ControllerMpd::parseTrackInfo Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1329,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:15:05 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1329,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:15:05 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: ControllerMpd::pushState Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::servicePushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1329,"duration":175,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"The Expert","artist":"Yello","album":"Touch Yello (Deluxe)","uri":"NAS/Music/Yello/2009 - Touch Yello (Deluxe)/01 - The Expert.flac","trackType":"flac"} Jan 18 21:15:05 volumio volumio[672]: verbose: CURRENT POSITION 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState stateService play Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::syncState currentStatus play Jan 18 21:15:05 volumio volumio[672]: info: Received an update from plugin. extracting info from payload Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:05 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:05 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 495ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 499ms Jan 18 21:15:05 volumio volumio[672]: info: ------------------------------ 499ms Jan 18 21:15:05 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:05 volumio volumio[672]: info: [GPIO_Control] Handling event: musicPlay Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: [GPIO_Control] Status changed: play Jan 18 21:15:06 volumio volumio[672]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 18 21:15:10 volumio volumio[672]: info: Preload queue cleared Jan 18 21:15:10 volumio volumio[672]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::ClearQueue Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::stop Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::stPlaybackTimer Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::updateTrackBlock Jan 18 21:15:10 volumio volumio[672]: info: CorePlayQueue::getTrackBlock Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::pushState Jan 18 21:15:10 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:10 volumio volumio[672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 21:15:10 volumio volumio[672]: info: CoreCommandRouter::volumioPushState Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::serviceStop Jan 18 21:15:10 volumio volumio[672]: info: CorePlayQueue::getTrack 0 Jan 18 21:15:10 volumio volumio[672]: info: CoreCommandRouter::serviceStop Jan 18 21:15:10 volumio volumio[672]: info: ControllerMpd::stop Jan 18 21:15:10 volumio volumio[672]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 21:15:10 volumio volumio[672]: info: CorePlayQueue::clearPlayQueue Jan 18 21:15:10 volumio volumio[672]: info: CorePlayQueue::saveQueue Jan 18 21:15:10 volumio volumio[672]: info: CoreCommandRouter::volumioPushQueue Jan 18 21:15:10 volumio volumio[672]: info: CoreStateMachine::addQueueItems Jan 18 21:15:10 volumio volumio[672]: info: CorePlayQueue::addQueueItems Jan 18 21:15:10 volumio volumio[672]: info: Preload queue cleared Jan 18 21:15:10 volumio volumio[672]: info: Adding Item to queue: music-library/NAS/Music/Yello/2014 - Malia - Boris Blank - Convergence Jan 18 21:15:10 volumio volumio[672]: info: Exploding uri music-library/NAS/Music/Yello/2014 - Malia - Boris Blank - Convergence in service mpd Jan 18 21:15:10 volumio volumio[672]: info: [GPIO_Control] Status changed: stop Jan 18 21:15:10 volumio volumio[672]: info: [GPIO_Control] Handling event: musicStop Jan 18 21:15:10 volumio volumio[672]: info: Jan 18 21:15:10 volumio volumio[672]: ---------------------------- MPD announces state update: player Jan 18 21:15:10 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2014%20-%20Malia%20-%20Boris%20Blank%20-%20Convergence%2FMalia%20%26%20Boris%20Blank%20%5BYello%5D%20-%20Convergence%2030RDT%20Skala%20LH.wv&metadata=false Jan 18 21:15:10 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2014 - Malia - Boris Blank - Convergence/Malia & Boris Blank [Yello] - Convergence 30RDT Skala LH.wv Jan 18 21:15:10 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Malia%20%26%20Boris%20Blank%20%5BYello%5D/Convergence/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2014%20-%20Malia%20-%20Boris%20Blank%20-%20Convergence%2FMalia%20%26%20Boris%20Blank%20%5BYello%5D%20-%20Convergence.cue&metadata=false Jan 18 21:15:10 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2014 - Malia - Boris Blank - Convergence/Malia & Boris Blank [Yello] - Convergence.cue Jan 18 21:15:10 volumio volumio[672]: info: ALBUMART /albumart?cacheid=888&web=Malia%20%26%20Boris%20Blank%20%5BYello%5D/Convergence/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FYello%2F2014%20-%20Malia%20-%20Boris%20Blank%20-%20Convergence%2FMalia%20%26%20Boris%20Blank%20%5BYello%5D%20-%20Convergence.cue&metadata=false Jan 18 21:15:10 volumio volumio[672]: info: URI /mnt/NAS/Music/Yello/2014 - Malia - Boris Blank - Convergence/Malia & Boris Blank [Yello] - Convergence.cue Jan 18 21:15:10 volumio volumio[672]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 21:15:10 volumio volumio[672]: Error: Unable to resolve or reject the same promise twice Jan 18 21:15:10 volumio volumio[672]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 18 21:15:10 volumio volumio[672]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Jan 18 21:15:10 volumio volumio[672]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jan 18 21:15:10 volumio volumio[672]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jan 18 21:15:10 volumio volumio[672]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jan 18 21:15:10 volumio volumio[672]: at Socket.emit (events.js:315:20) Jan 18 21:15:10 volumio volumio[672]: at addChunk (internal/streams/readable.js:309:12) Jan 18 21:15:10 volumio volumio[672]: at readableAddChunk (internal/streams/readable.js:280:11) Jan 18 21:15:10 volumio volumio[672]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jan 18 21:15:10 volumio volumio[672]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jan 18 21:15:10 volumio volumio[672]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 21:15:10 volumio sudo[1739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 21:14 Jan 18 21:15:10 volumio sudo[1739]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"