-- Logs begin at Mon 2024-12-02 16:30:41 CET, end at Mon 2024-12-02 17:58:16 CET. -- Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 02 17:57:10 volumio-minipc volumio[883]: info: Discovery: Getting this device information Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetState Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 02 17:57:10 volumio-minipc volumio[883]: info: Discovery: Getting this device information Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetState Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 02 17:57:10 volumio-minipc volumio[883]: info: Discovery: Getting this device information Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetState Dec 02 17:57:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 02 17:57:10 volumio-minipc volumio[883]: verbose: New Socket.io Connection to 192.168.188.103:3000 from 192.168.188.111 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Dec 02 17:57:11 volumio-minipc volumio[883]: verbose: New Socket.io Connection to 192.168.188.103 from 192.168.188.111 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Dec 02 17:57:11 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetState Dec 02 17:57:11 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 02 17:57:11 volumio-minipc volumio[883]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 02 17:57:11 volumio-minipc volumio[883]: info: Listing playlists Dec 02 17:57:11 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetVisibleSources Dec 02 17:57:11 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 02 17:57:11 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetQueue Dec 02 17:57:11 volumio-minipc volumio[883]: info: CoreStateMachine::getQueue Dec 02 17:57:11 volumio-minipc volumio[883]: info: CorePlayQueue::getQueue Dec 02 17:57:14 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 5 Dec 02 17:57:14 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 6 Dec 02 17:57:14 volumio-minipc volumio[883]: info: Prefetching next song Dec 02 17:57:14 volumio-minipc volumio[883]: info: Doing Prefetch in UPNP Dec 02 17:57:14 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.188.93:32469/object/7378ce4428cbcb798c98/file.flac" Dec 02 17:57:14 volumio-minipc volumio[883]: info: Dec 02 17:57:14 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:14 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:14 volumio-minipc volumio[883]: info: sendMpdCommand add "http://192.168.188.93:32469/object/7378ce4428cbcb798c98/file.flac" took 2 milliseconds Dec 02 17:57:14 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 02 17:57:14 volumio-minipc volumio[883]: info: ------------------------------ 6ms Dec 02 17:57:14 volumio-minipc volumio[883]: info: sendMpdCommand consume 1 took 5 milliseconds Dec 02 17:57:17 volumio-minipc volumio[883]: info: Dec 02 17:57:17 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:17 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:17 volumio-minipc volumio[883]: info: Dec 02 17:57:17 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:17 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:17 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:17 volumio-minipc volumio[883]: info: ------------------------------ 2ms Dec 02 17:57:17 volumio-minipc volumio[883]: info: sendMpdCommand status took 1 milliseconds Dec 02 17:57:17 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:17 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:17 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 02 17:57:17 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:17 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:57:17 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 5 Dec 02 17:57:17 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1244 Kbps","isStreaming":false,"title":"Mombasa","artist":"2Cellos","album":"Celloverse (Japan Version)","uri":"http://192.168.188.93:32469/object/7378ce4428cbcb798c98/file.flac","trackType":"flac"} Dec 02 17:57:17 volumio-minipc volumio[883]: verbose: CURRENT POSITION 5 Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus play Dec 02 17:57:17 volumio-minipc volumio[883]: info: Received an update from plugin. extracting info from payload Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:17 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:17 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:17 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:17 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:17 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:17 volumio-minipc volumio[883]: info: ------------------------------ 30ms Dec 02 17:57:17 volumio-minipc volumio[883]: info: [LastFM] Current track has sufficient metadata: title (Mombasa) and artist (2Cellos) passed on explicitly Dec 02 17:57:17 volumio-minipc volumio[883]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Dec 02 17:57:17 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:18 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:18 volumio-minipc sudo[17122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:18 volumio-minipc sudo[17122]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:18 volumio-minipc sudo[17122]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:18 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetQueue Dec 02 17:57:18 volumio-minipc volumio[883]: info: CoreStateMachine::getQueue Dec 02 17:57:18 volumio-minipc volumio[883]: info: CorePlayQueue::getQueue Dec 02 17:57:18 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetQueue Dec 02 17:57:18 volumio-minipc volumio[883]: info: CoreStateMachine::getQueue Dec 02 17:57:18 volumio-minipc volumio[883]: info: CorePlayQueue::getQueue Dec 02 17:57:18 volumio-minipc sudo[17125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:18 volumio-minipc sudo[17125]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:18 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:18 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:18 volumio-minipc sudo[17125]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:18 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:18 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:18 volumio-minipc volumio[883]: info: CoreStateMachine::startPlaybackTimer Dec 02 17:57:18 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 6 Dec 02 17:57:19 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:19 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 6 Dec 02 17:57:19 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:19 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:19 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:19 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:19 volumio-minipc volumio[883]: info: [LastFM] updating timer, previous duration is obsolete; adding -750 milliseconds. Dec 02 17:57:19 volumio-minipc volumio[883]: Currently remaining: 163500 Dec 02 17:57:19 volumio-minipc volumio[883]: -------------------------------------------------// Adding -750 milliseconds to a total of 162750. Dec 02 17:57:19 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:19 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetQueue Dec 02 17:57:19 volumio-minipc volumio[883]: info: CoreStateMachine::getQueue Dec 02 17:57:19 volumio-minipc volumio[883]: info: CorePlayQueue::getQueue Dec 02 17:57:19 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:19 volumio-minipc sudo[17128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:19 volumio-minipc sudo[17128]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:19 volumio-minipc sudo[17128]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:19 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:29 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:29 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:29 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:29 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:38 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 02 17:57:38 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:40 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 02 17:57:40 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 02 17:57:40 volumio-minipc volumio[883]: info: Discovery: Getting this device information Dec 02 17:57:40 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetState Dec 02 17:57:40 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 6 Dec 02 17:57:40 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 02 17:57:41 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7d3856d319ee19fafb13 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0b8ab28369c160072890 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@d96ce954d4aacf572009 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69e94cce322ff9066f71 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@5f02599883c067ae0b65 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a9eb0a6a09aa3a8cc8b Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@994282fed62c48eb559d Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@9df127e4ae1808302218 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69c24379b102cf9daed3 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3c919ec6fd3c9c6bcc8a Dec 02 17:57:41 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@86c676ffc732ceddd806 Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7d3856d319ee19fafb13 in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0b8ab28369c160072890 in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@d96ce954d4aacf572009 in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69e94cce322ff9066f71 in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@5f02599883c067ae0b65 in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a9eb0a6a09aa3a8cc8b in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@994282fed62c48eb559d in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@9df127e4ae1808302218 in service upnp_browser Dec 02 17:57:41 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69c24379b102cf9daed3 in service upnp_browser Dec 02 17:57:42 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3c919ec6fd3c9c6bcc8a in service upnp_browser Dec 02 17:57:42 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@86c676ffc732ceddd806 in service upnp_browser Dec 02 17:57:43 volumio-minipc volumio[883]: error: Failed request for metavolumio API Dec 02 17:57:43 volumio-minipc volumio[883]: error: Failed request for metavolumio API Dec 02 17:57:43 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::ClearQueue Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::stPlaybackTimer Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:43 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:43 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 6 Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:43 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:43 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::serviceStop Dec 02 17:57:43 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 6 Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreCommandRouter::serviceStop Dec 02 17:57:43 volumio-minipc volumio[883]: info: [1733158663990] ControllerUPNPBrowser::stop Dec 02 17:57:43 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:57:43 volumio-minipc volumio[883]: info: CorePlayQueue::clearPlayQueue Dec 02 17:57:43 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:43 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:57:43 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:57:43 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:43 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7d3856d319ee19fafb13 Dec 02 17:57:43 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7d3856d319ee19fafb13 Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPlay Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::play index 0 Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:57:44 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0b8ab28369c160072890 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0b8ab28369c160072890 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@d96ce954d4aacf572009 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@d96ce954d4aacf572009 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69e94cce322ff9066f71 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69e94cce322ff9066f71 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@5f02599883c067ae0b65 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@5f02599883c067ae0b65 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a9eb0a6a09aa3a8cc8b Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a9eb0a6a09aa3a8cc8b Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@994282fed62c48eb559d Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@994282fed62c48eb559d Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@9df127e4ae1808302218 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@9df127e4ae1808302218 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69c24379b102cf9daed3 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@69c24379b102cf9daed3 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3c919ec6fd3c9c6bcc8a Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3c919ec6fd3c9c6bcc8a Dec 02 17:57:44 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@86c676ffc732ceddd806 Dec 02 17:57:44 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@86c676ffc732ceddd806 Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::play index undefined Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::startPlaybackTimer Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:44 volumio-minipc volumio[883]: info: [1733158664038] ControllerUPNPBrowser::clearAddPlayTrack Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:57:44 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 02 17:57:44 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:44 volumio-minipc sudo[17170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 02 17:57:44 volumio-minipc sudo[17170]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:44 volumio-minipc volumio[883]: info: Dec 02 17:57:44 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand stop took 144 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand stop took 97 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 17:57:44 volumio-minipc volumio[883]: info: Dec 02 17:57:44 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:44 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand status took 10 milliseconds Dec 02 17:57:44 volumio-minipc systemd[1]: Stopping peppymeterbasic Daemon... Dec 02 17:57:44 volumio-minipc systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand clear took 9 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.188.93:32469/object/7d3856d319ee19fafb13/file.mp3" Dec 02 17:57:44 volumio-minipc volumio[883]: error: updateQueue error: null Dec 02 17:57:44 volumio-minipc volumio[883]: info: ------------------------------ 16ms Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:44 volumio-minipc volumio[883]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 02 17:57:44 volumio-minipc volumio[883]: info: ------------------------------ 31ms Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.188.93:32469/object/7d3856d319ee19fafb13/file.mp3" Dec 02 17:57:44 volumio-minipc volumio[883]: info: Dec 02 17:57:44 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:44 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand add "http://192.168.188.93:32469/object/7d3856d319ee19fafb13/file.mp3" took 2 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand play Dec 02 17:57:44 volumio-minipc volumio[883]: info: ------------------------------ 4ms Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand play took 1 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: info: Dec 02 17:57:44 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:44 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:44 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 02 17:57:44 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 02 17:57:44 volumio-minipc volumio[883]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 02 17:57:44 volumio-minipc volumio[883]: info: Dec 02 17:57:44 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand status took 28 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand status took 7 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:44 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/7d3856d319ee19fafb13/file.mp3","trackType":"mp3"} Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus stop Dec 02 17:57:44 volumio-minipc volumio[883]: info: ------------------------------ 48ms Dec 02 17:57:44 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:44 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:57:44 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":276,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/7d3856d319ee19fafb13/file.mp3","trackType":"mp3"} Dec 02 17:57:44 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus play Dec 02 17:57:44 volumio-minipc volumio[883]: info: Received an update from plugin. extracting info from payload Dec 02 17:57:44 volumio-minipc systemd[1]: peppymeterbasic.service: Succeeded. Dec 02 17:57:44 volumio-minipc systemd[1]: Stopped peppymeterbasic Daemon. Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:44 volumio-minipc sudo[17170]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:44 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:44 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:44 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:44 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:44 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:44 volumio-minipc volumio[883]: info: ------------------------------ 106ms Dec 02 17:57:44 volumio-minipc volumio[883]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 02 17:57:44 volumio-minipc volumio[883]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! file.mp3 Dec 02 17:57:44 volumio-minipc volumio[883]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! file.mp3 Dec 02 17:57:44 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:44 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:44 volumio-minipc sudo[17179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:44 volumio-minipc sudo[17179]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:44 volumio-minipc systemd[1]: Started peppymeterbasic Daemon. Dec 02 17:57:44 volumio-minipc sudo[17179]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:44 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:44 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:44 volumio-minipc sudo[17185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:44 volumio-minipc sudo[17185]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:44 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Stop Dec 02 17:57:44 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:44 volumio-minipc sudo[17185]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:44 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:45 volumio-minipc volumio[17183]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:57:45 volumio-minipc volumio[17183]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:57:45 volumio-minipc volumio[17183]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:57:50 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@a4a445512b097a7ffbcc Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@636f70b089f0546d08a2 Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@14c68d1d8e49aabb0a7e Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@f4780a1294e39d283baf Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@eae9b7f52806ef500542 Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b10c153d8bc4760e27cc Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@fd948cc610932e560064 Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@49ef5c9d48516ac28dc9 Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@00047323547b785dd2a1 Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@2c8f503e7b1c1db6cedd Dec 02 17:57:50 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@aee160f5d47be5c47c06 Dec 02 17:57:50 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:50 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@a4a445512b097a7ffbcc in service upnp_browser Dec 02 17:57:50 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@636f70b089f0546d08a2 in service upnp_browser Dec 02 17:57:50 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@14c68d1d8e49aabb0a7e in service upnp_browser Dec 02 17:57:50 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@f4780a1294e39d283baf in service upnp_browser Dec 02 17:57:50 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@eae9b7f52806ef500542 in service upnp_browser Dec 02 17:57:51 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b10c153d8bc4760e27cc in service upnp_browser Dec 02 17:57:51 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@fd948cc610932e560064 in service upnp_browser Dec 02 17:57:51 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@49ef5c9d48516ac28dc9 in service upnp_browser Dec 02 17:57:51 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@00047323547b785dd2a1 in service upnp_browser Dec 02 17:57:51 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@2c8f503e7b1c1db6cedd in service upnp_browser Dec 02 17:57:51 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@aee160f5d47be5c47c06 in service upnp_browser Dec 02 17:57:52 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::ClearQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::stPlaybackTimer Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:52 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::serviceStop Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::serviceStop Dec 02 17:57:52 volumio-minipc volumio[883]: info: [1733158672070] ControllerUPNPBrowser::stop Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::clearPlayQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:57:52 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@a4a445512b097a7ffbcc Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@a4a445512b097a7ffbcc Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPlay Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::play index 0 Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:57:52 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@636f70b089f0546d08a2 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@636f70b089f0546d08a2 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@14c68d1d8e49aabb0a7e Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@14c68d1d8e49aabb0a7e Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@f4780a1294e39d283baf Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@f4780a1294e39d283baf Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@eae9b7f52806ef500542 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@eae9b7f52806ef500542 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b10c153d8bc4760e27cc Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b10c153d8bc4760e27cc Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@fd948cc610932e560064 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@fd948cc610932e560064 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@49ef5c9d48516ac28dc9 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@49ef5c9d48516ac28dc9 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@00047323547b785dd2a1 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@00047323547b785dd2a1 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@2c8f503e7b1c1db6cedd Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@2c8f503e7b1c1db6cedd Dec 02 17:57:52 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@aee160f5d47be5c47c06 Dec 02 17:57:52 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@aee160f5d47be5c47c06 Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::play index undefined Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::startPlaybackTimer Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:52 volumio-minipc volumio[883]: info: [1733158672107] ControllerUPNPBrowser::clearAddPlayTrack Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:57:52 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 02 17:57:52 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:52 volumio-minipc sudo[17208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 02 17:57:52 volumio-minipc sudo[17208]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:52 volumio-minipc volumio[883]: info: Dec 02 17:57:52 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand stop took 183 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand stop took 144 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 17:57:52 volumio-minipc volumio[883]: info: Dec 02 17:57:52 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:52 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand status took 14 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand clear took 14 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.188.93:32469/object/a4a445512b097a7ffbcc/file.mp3" Dec 02 17:57:52 volumio-minipc systemd[1]: Stopping peppymeterbasic Daemon... Dec 02 17:57:52 volumio-minipc systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Dec 02 17:57:52 volumio-minipc volumio[883]: error: updateQueue error: null Dec 02 17:57:52 volumio-minipc volumio[883]: info: ------------------------------ 18ms Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.188.93:32469/object/a4a445512b097a7ffbcc/file.mp3" Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:52 volumio-minipc volumio[883]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 02 17:57:52 volumio-minipc volumio[883]: info: ------------------------------ 32ms Dec 02 17:57:52 volumio-minipc volumio[883]: info: Dec 02 17:57:52 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:52 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand add "http://192.168.188.93:32469/object/a4a445512b097a7ffbcc/file.mp3" took 5 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand play Dec 02 17:57:52 volumio-minipc volumio[883]: info: ------------------------------ 5ms Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand play took 3 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: info: Dec 02 17:57:52 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:52 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:52 volumio-minipc systemd[1]: peppymeterbasic.service: Succeeded. Dec 02 17:57:52 volumio-minipc systemd[1]: Stopped peppymeterbasic Daemon. Dec 02 17:57:52 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 02 17:57:52 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 02 17:57:52 volumio-minipc volumio[883]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 02 17:57:52 volumio-minipc volumio[883]: info: Dec 02 17:57:52 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand status took 57 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand status took 1 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:52 volumio-minipc sudo[17208]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:52 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/a4a445512b097a7ffbcc/file.mp3","trackType":"mp3"} Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus stop Dec 02 17:57:52 volumio-minipc volumio[883]: info: ------------------------------ 77ms Dec 02 17:57:52 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:52 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":304,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/a4a445512b097a7ffbcc/file.mp3","trackType":"mp3"} Dec 02 17:57:52 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus play Dec 02 17:57:52 volumio-minipc volumio[883]: info: Received an update from plugin. extracting info from payload Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:52 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:52 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:52 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:52 volumio-minipc volumio[883]: info: ------------------------------ 75ms Dec 02 17:57:52 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Stop Dec 02 17:57:52 volumio-minipc volumio[883]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! file.mp3 Dec 02 17:57:52 volumio-minipc volumio[883]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! file.mp3 Dec 02 17:57:52 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:52 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:52 volumio-minipc sudo[17215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:52 volumio-minipc sudo[17215]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:52 volumio-minipc systemd[1]: Started peppymeterbasic Daemon. Dec 02 17:57:52 volumio-minipc sudo[17215]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:52 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:52 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:52 volumio-minipc sudo[17220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:52 volumio-minipc sudo[17220]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:52 volumio-minipc volumio[883]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 02 17:57:52 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:52 volumio-minipc sudo[17220]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:52 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:53 volumio-minipc volumio[17218]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:57:53 volumio-minipc volumio[17218]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:57:53 volumio-minipc volumio[17218]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:57:55 volumio-minipc volumiologrotate[608]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Dec 02 17:57:55 volumio-minipc volumiologrotate[608]: ls: cannot access 'MINIPC': No such file or directory Dec 02 17:57:57 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@618c55866eb887334c82 Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b81cc05daab6cdc4bf38 Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@23142b6ae0786dd0e1ca Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@4c675aff91e6fc4370ca Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@470358f8fd2f307c55bf Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@94eb8929ea0bda4e7f81 Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a933fa4e7bb0eb552e2 Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7f17a665e102a7badf7b Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@6e68a6533c5096c6b0b2 Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0dcb6ac8bb28cb8ff4a7 Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3f2779fe4cfe3ace91ac Dec 02 17:57:57 volumio-minipc volumio[883]: info: Preloading song: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7268ef175964d3135c24 Dec 02 17:57:57 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: Executing endpoint metavolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 02 17:57:57 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@618c55866eb887334c82 in service upnp_browser Dec 02 17:57:57 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b81cc05daab6cdc4bf38 in service upnp_browser Dec 02 17:57:57 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@23142b6ae0786dd0e1ca in service upnp_browser Dec 02 17:57:57 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@4c675aff91e6fc4370ca in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@470358f8fd2f307c55bf in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@94eb8929ea0bda4e7f81 in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a933fa4e7bb0eb552e2 in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7f17a665e102a7badf7b in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@6e68a6533c5096c6b0b2 in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0dcb6ac8bb28cb8ff4a7 in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3f2779fe4cfe3ace91ac in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Exploding uri upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7268ef175964d3135c24 in service upnp_browser Dec 02 17:57:58 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::ClearQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::stPlaybackTimer Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:58 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:58 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::serviceStop Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::serviceStop Dec 02 17:57:58 volumio-minipc volumio[883]: info: [1733158678891] ControllerUPNPBrowser::stop Dec 02 17:57:58 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::clearPlayQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:57:58 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@618c55866eb887334c82 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@618c55866eb887334c82 Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPlay Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::play index 0 Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:57:58 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b81cc05daab6cdc4bf38 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b81cc05daab6cdc4bf38 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@23142b6ae0786dd0e1ca Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@23142b6ae0786dd0e1ca Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@4c675aff91e6fc4370ca Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@4c675aff91e6fc4370ca Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@470358f8fd2f307c55bf Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@470358f8fd2f307c55bf Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@94eb8929ea0bda4e7f81 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@94eb8929ea0bda4e7f81 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a933fa4e7bb0eb552e2 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a933fa4e7bb0eb552e2 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7f17a665e102a7badf7b Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7f17a665e102a7badf7b Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@6e68a6533c5096c6b0b2 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@6e68a6533c5096c6b0b2 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0dcb6ac8bb28cb8ff4a7 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0dcb6ac8bb28cb8ff4a7 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3f2779fe4cfe3ace91ac Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3f2779fe4cfe3ace91ac Dec 02 17:57:58 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7268ef175964d3135c24 Dec 02 17:57:58 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7268ef175964d3135c24 Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::play index undefined Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:58 volumio-minipc volumio[883]: info: CoreStateMachine::startPlaybackTimer Dec 02 17:57:58 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:58 volumio-minipc volumio[883]: info: [1733158678937] ControllerUPNPBrowser::clearAddPlayTrack Dec 02 17:57:58 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:57:58 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 02 17:57:59 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:59 volumio-minipc sudo[17287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 02 17:57:59 volumio-minipc sudo[17287]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:59 volumio-minipc volumio[883]: info: Dec 02 17:57:59 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand stop took 174 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand stop took 126 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 17:57:59 volumio-minipc systemd[1]: Stopping peppymeterbasic Daemon... Dec 02 17:57:59 volumio-minipc systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Dec 02 17:57:59 volumio-minipc volumio[883]: info: Dec 02 17:57:59 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:59 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand status took 13 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand clear took 13 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3" Dec 02 17:57:59 volumio-minipc volumio[883]: error: updateQueue error: null Dec 02 17:57:59 volumio-minipc volumio[883]: info: ------------------------------ 8ms Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:59 volumio-minipc volumio[883]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 02 17:57:59 volumio-minipc volumio[883]: info: ------------------------------ 25ms Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3" Dec 02 17:57:59 volumio-minipc volumio[883]: info: Dec 02 17:57:59 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:57:59 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand add "http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3" took 2 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand play Dec 02 17:57:59 volumio-minipc volumio[883]: info: ------------------------------ 3ms Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand play took 2 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: info: Dec 02 17:57:59 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:59 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 02 17:57:59 volumio-minipc systemd[1]: peppymeterbasic.service: Succeeded. Dec 02 17:57:59 volumio-minipc systemd[1]: Stopped peppymeterbasic Daemon. Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 02 17:57:59 volumio-minipc volumio[883]: info: Dec 02 17:57:59 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand status took 39 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:59 volumio-minipc sudo[17287]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand status took 14 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:59 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3","trackType":"mp3"} Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus stop Dec 02 17:57:59 volumio-minipc volumio[883]: info: ------------------------------ 66ms Dec 02 17:57:59 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Stop Dec 02 17:57:59 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:57:59 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3","trackType":"mp3"} Dec 02 17:57:59 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus play Dec 02 17:57:59 volumio-minipc volumio[883]: info: Received an update from plugin. extracting info from payload Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:59 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:57:59 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:57:59 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:57:59 volumio-minipc volumio[883]: info: ------------------------------ 100ms Dec 02 17:57:59 volumio-minipc volumio[883]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! file.mp3 Dec 02 17:57:59 volumio-minipc volumio[883]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! file.mp3 Dec 02 17:57:59 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:59 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:57:59 volumio-minipc sudo[17295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:59 volumio-minipc sudo[17295]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:59 volumio-minipc systemd[1]: Started peppymeterbasic Daemon. Dec 02 17:57:59 volumio-minipc sudo[17295]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:59 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:59 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 02 17:57:59 volumio-minipc sudo[17300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:57:59 volumio-minipc sudo[17300]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:57:59 volumio-minipc volumio[883]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 02 17:57:59 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:57:59 volumio-minipc sudo[17300]: pam_unix(sudo:session): session closed for user root Dec 02 17:57:59 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:58:00 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::ClearQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::stPlaybackTimer Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:58:00 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::serviceStop Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::serviceStop Dec 02 17:58:00 volumio-minipc volumio[883]: info: [1733158680212] ControllerUPNPBrowser::stop Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::clearPlayQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:58:00 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@618c55866eb887334c82 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@618c55866eb887334c82 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPlay Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::play index 0 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::addQueueItems Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::addQueueItems Dec 02 17:58:00 volumio-minipc volumio[883]: info: Preload queue cleared Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b81cc05daab6cdc4bf38 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@b81cc05daab6cdc4bf38 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@23142b6ae0786dd0e1ca Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@23142b6ae0786dd0e1ca Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@4c675aff91e6fc4370ca Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@4c675aff91e6fc4370ca Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@470358f8fd2f307c55bf Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@470358f8fd2f307c55bf Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@94eb8929ea0bda4e7f81 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@94eb8929ea0bda4e7f81 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a933fa4e7bb0eb552e2 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@8a933fa4e7bb0eb552e2 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7f17a665e102a7badf7b Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7f17a665e102a7badf7b Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@6e68a6533c5096c6b0b2 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@6e68a6533c5096c6b0b2 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0dcb6ac8bb28cb8ff4a7 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@0dcb6ac8bb28cb8ff4a7 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3f2779fe4cfe3ace91ac Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@3f2779fe4cfe3ace91ac Dec 02 17:58:00 volumio-minipc volumio[883]: info: Adding Item to queue: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7268ef175964d3135c24 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Using cached record of: upnp/http://192.168.188.93:32469/ContentDirectory/be0f59dc-f837-12b2-ae59-74777e1d42ce/control.xml@7268ef175964d3135c24 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::stop Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::saveQueue Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::play index undefined Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::updateTrackBlock Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrackBlock Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::startPlaybackTimer Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:58:00 volumio-minipc volumio[883]: info: [1733158680328] ControllerUPNPBrowser::clearAddPlayTrack Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand stop Dec 02 17:58:00 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 02 17:58:00 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:58:00 volumio-minipc volumio[883]: info: Dec 02 17:58:00 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:58:00 volumio-minipc sudo[17305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand stop took 263 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand stop took 153 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand clear Dec 02 17:58:00 volumio-minipc sudo[17305]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:58:00 volumio-minipc volumio[883]: info: Dec 02 17:58:00 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:58:00 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand status took 12 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand clear took 10 milliseconds Dec 02 17:58:00 volumio-minipc volumio[17298]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3" Dec 02 17:58:00 volumio-minipc systemd[1]: Stopping peppymeterbasic Daemon... Dec 02 17:58:00 volumio-minipc systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Dec 02 17:58:00 volumio-minipc volumio[883]: error: updateQueue error: null Dec 02 17:58:00 volumio-minipc volumio[883]: info: ------------------------------ 58ms Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 44 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3" Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:58:00 volumio-minipc volumio[883]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 02 17:58:00 volumio-minipc volumio[17298]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:58:00 volumio-minipc volumio[883]: info: ------------------------------ 98ms Dec 02 17:58:00 volumio-minipc volumio[883]: info: Dec 02 17:58:00 volumio-minipc volumio[883]: ---------------------------- MPD announces system playlist update Dec 02 17:58:00 volumio-minipc volumio[883]: info: Ignoring MPD Status Update Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand add "http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3" took 14 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand play Dec 02 17:58:00 volumio-minipc volumio[883]: info: ------------------------------ 2ms Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand play took 1 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: info: Dec 02 17:58:00 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:58:00 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:58:00 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 02 17:58:00 volumio-minipc volumio[883]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 02 17:58:00 volumio-minipc volumio[883]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 02 17:58:00 volumio-minipc volumio[883]: info: Dec 02 17:58:00 volumio-minipc volumio[883]: ---------------------------- MPD announces state update: player Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand status took 46 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: info: ControllerMpd::getState Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand status Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand status took 13 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::parseState Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:58:00 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3","trackType":"mp3"} Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus stop Dec 02 17:58:00 volumio-minipc volumio[883]: info: ------------------------------ 78ms Dec 02 17:58:00 volumio-minipc volumio[883]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: ControllerMpd::parseTrackInfo Dec 02 17:58:00 volumio-minipc volumio[883]: info: ControllerMpd::pushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::servicePushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: CorePlayQueue::getTrack 0 Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":268,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"file.mp3","artist":null,"album":null,"uri":"http://192.168.188.93:32469/object/618c55866eb887334c82/file.mp3","trackType":"mp3"} Dec 02 17:58:00 volumio-minipc volumio[883]: verbose: CURRENT POSITION 0 Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::syncState stateService play Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::syncState currentStatus play Dec 02 17:58:00 volumio-minipc volumio[883]: info: Received an update from plugin. extracting info from payload Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:58:00 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreStateMachine::pushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioPushState Dec 02 17:58:00 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output update for this device Dec 02 17:58:00 volumio-minipc volumio[883]: info: MRS: Pushing multiroomSync output Dec 02 17:58:00 volumio-minipc volumio[883]: info: ------------------------------ 86ms Dec 02 17:58:00 volumio-minipc volumio[883]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! file.mp3 Dec 02 17:58:00 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:58:00 volumio-minipc volumio[17298]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:58:00 volumio-minipc volumio[883]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 02 17:58:00 volumio-minipc systemd[1]: peppymeterbasic.service: Succeeded. Dec 02 17:58:00 volumio-minipc systemd[1]: Stopped peppymeterbasic Daemon. Dec 02 17:58:00 volumio-minipc sudo[17313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:58:00 volumio-minipc sudo[17313]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:58:00 volumio-minipc sudo[17305]: pam_unix(sudo:session): session closed for user root Dec 02 17:58:00 volumio-minipc systemd[1]: Started peppymeterbasic Daemon. Dec 02 17:58:00 volumio-minipc sudo[17313]: pam_unix(sudo:session): session closed for user root Dec 02 17:58:00 volumio-minipc volumio[883]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Dec 02 17:58:00 volumio-minipc sudo[17318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 02 17:58:01 volumio-minipc volumio[883]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 02 17:58:01 volumio-minipc sudo[17318]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 02 17:58:01 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:58:01 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Stop Dec 02 17:58:01 volumio-minipc sudo[17318]: pam_unix(sudo:session): session closed for user root Dec 02 17:58:01 volumio-minipc volumio[883]: info: camilladsp spawned new process with pid 17320, instance 1, run: true Dec 02 17:58:01 volumio-minipc volumio[883]: info: peppymeterbasic Daemon Started Dec 02 17:58:01 volumio-minipc volumio[17316]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:58:01 volumio-minipc volumio[17316]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:58:01 volumio-minipc volumio[17316]: libpng warning: iCCP: known incorrect sRGB profile Dec 02 17:58:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 02 17:58:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 02 17:58:10 volumio-minipc volumio[883]: info: Discovery: Getting this device information Dec 02 17:58:10 volumio-minipc volumio[883]: info: CoreCommandRouter::volumioGetState Dec 02 17:58:10 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 02 17:58:15 volumio-minipc volumio[883]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 02 17:58:16 volumio-minipc volumio[883]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 02 17:58:16 volumio-minipc volumio[883]: TypeError: Cannot read property 'length' of undefined Dec 02 17:58:16 volumio-minipc volumio[883]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Dec 02 17:58:16 volumio-minipc volumio[883]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Dec 02 17:58:16 volumio-minipc volumio[883]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Dec 02 17:58:16 volumio-minipc volumio[883]: at Parser.emit (events.js:400:28) Dec 02 17:58:16 volumio-minipc volumio[883]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Dec 02 17:58:16 volumio-minipc volumio[883]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Dec 02 17:58:16 volumio-minipc volumio[883]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Dec 02 17:58:16 volumio-minipc volumio[883]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Dec 02 17:58:16 volumio-minipc volumio[883]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Dec 02 17:58:16 volumio-minipc volumio[883]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Dec 02 17:58:16 volumio-minipc volumio[883]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Dec 02 17:58:16 volumio-minipc volumio[883]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Dec 02 17:58:16 volumio-minipc volumio[883]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Dec 02 17:58:16 volumio-minipc volumio[883]: at IncomingMessage.emit (events.js:412:35) Dec 02 17:58:16 volumio-minipc volumio[883]: at endReadableNT (internal/streams/readable.js:1333:12) Dec 02 17:58:16 volumio-minipc volumio[883]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Dec 02 17:58:16 volumio-minipc volumio[883]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 02 17:58:16 volumio-minipc sudo[17361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-02 17:57 Dec 02 17:58:16 volumio-minipc sudo[17361]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"