Dec 06 16:06:24 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::ClearQueue Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::stPlaybackTimer Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::serviceStop Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::serviceStop Dec 06 16:06:24 volumio volumio[1211]: info: [1765033584031] ControllerTidal::stop Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::stop Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::clearPlayQueue Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:24 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/2571072 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/2571072 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875394 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/3875394 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875469 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/3875469 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/79636534 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/79636534 Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPlay Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::play index 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:24 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3717973 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/3717973 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/22355053 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/22355053 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665930 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/162665930 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/93327370 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/93327370 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/30055691 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/30055691 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3749626 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/3749626 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/64325809 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/64325809 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/458663828 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/458663828 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665824 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/162665824 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/168418438 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/168418438 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/154984887 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/154984887 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/5001181 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/5001181 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/35740418 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/35740418 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/14131695 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/14131695 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284797 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/26284797 Dec 06 16:06:24 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284836 Dec 06 16:06:24 volumio volumio[1211]: info: Using cached record of: tidal://song/26284836 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::play index undefined Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::startPlaybackTimer Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: [1765033584059] ControllerTidal::clearAddPlayTrack Dec 06 16:06:24 volumio volumio[1211]: info: Getting stream with soundQuality HI_RES Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand stop took 58 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand status took 2 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand status took 2 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:24 volumio sudo[27352]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27352]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 35ms Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 34ms Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:24 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 06 16:06:24 volumio sudo[27357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio sudo[27359]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio volumio[1211]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 06 16:06:24 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 06 16:06:24 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:24 volumio systemd[1]: peppymeterbasic.service: Consumed 33.316s CPU time. Dec 06 16:06:24 volumio sudo[27357]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:24 volumio sudo[27359]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio sudo[27352]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:24 volumio volumio[1211]: info: getStreamUrl took 296 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand stop took 0 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:24 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand clear took 1 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmMDU1Yzc1NzExZjMxMDAwYmMxMGI0NDllYmJjMDk1Y182MS5tcDQ/0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==" Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:24 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:24 volumio volumio[1211]: error: updateQueue error: null Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:24 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 2ms Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmMDU1Yzc1NzExZjMxMDAwYmMxMGI0NDllYmJjMDk1Y182MS5tcDQ/0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==" took 2 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 2ms Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand play Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:24 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 3ms Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand play took 2 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 1ms Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand status took 46 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:24 volumio volumio[1211]: info: Dec 06 16:06:24 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand status took 48 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmMDU1Yzc1NzExZjMxMDAwYmMxMGI0NDllYmJjMDk1Y182MS5tcDQ/0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","trackType":"tidal"} Dec 06 16:06:24 volumio volumio[1211]: verbose: CURRENT POSITION 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus stop Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 51ms Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand status took 4 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand status took 4 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":687,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"579 Kbps","isStreaming":false,"title":"0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmMDU1Yzc1NzExZjMxMDAwYmMxMGI0NDllYmJjMDk1Y182MS5tcDQ/0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","trackType":"tidal"} Dec 06 16:06:24 volumio volumio[1211]: verbose: CURRENT POSITION 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:24 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1008,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"702 Kbps","isStreaming":false,"title":"0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmMDU1Yzc1NzExZjMxMDAwYmMxMGI0NDllYmJjMDk1Y182MS5tcDQ/0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","trackType":"tidal"} Dec 06 16:06:24 volumio volumio[1211]: verbose: CURRENT POSITION 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:24 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 90ms Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 44ms Dec 06 16:06:24 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 40 milliseconds Dec 06 16:06:24 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:24 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:24 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:24 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1026 Kbps","isStreaming":false,"title":"0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmMDU1Yzc1NzExZjMxMDAwYmMxMGI0NDllYmJjMDk1Y182MS5tcDQ/0.flac?token=1765037148~ZjYxMmFhMmRmZGY3MGQ1ZWViZjA4MjhiYTUzN2FmNDA5MzA2Nzg2Nw==","trackType":"tidal"} Dec 06 16:06:24 volumio volumio[1211]: verbose: CURRENT POSITION 3 Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:24 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:24 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:24 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:24 volumio volumio[1211]: info: ------------------------------ 62ms Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:24 volumio sudo[27366]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27366]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio sudo[27371]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:24 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:24 volumio sudo[27374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio sudo[27376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio sudo[27376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio sudo[27379]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:24 volumio sudo[27379]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:24 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:24 volumio sudo[27366]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:24 volumio sudo[27371]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:24 volumio sudo[27376]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio sudo[27374]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio sudo[27379]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:24 volumio sudo[27368]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:24 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:26 volumio volumio[27385]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:06:26 volumio volumio[27385]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:06:27 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::ClearQueue Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::stPlaybackTimer Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:27 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:27 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::serviceStop Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 3 Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::serviceStop Dec 06 16:06:27 volumio volumio[1211]: info: [1765033587812] ControllerTidal::stop Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:27 volumio volumio[1211]: info: ControllerMpd::stop Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::clearPlayQueue Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:27 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/2571072 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/2571072 Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioPlay Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::play index 0 Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:27 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875394 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/3875394 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875469 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/3875469 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/79636534 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/79636534 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3717973 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/3717973 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/22355053 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/22355053 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665930 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/162665930 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/93327370 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/93327370 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/30055691 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/30055691 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3749626 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/3749626 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/64325809 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/64325809 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/458663828 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/458663828 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665824 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/162665824 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/168418438 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/168418438 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/154984887 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/154984887 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/5001181 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/5001181 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/35740418 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/35740418 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/14131695 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/14131695 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284797 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/26284797 Dec 06 16:06:27 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284836 Dec 06 16:06:27 volumio volumio[1211]: info: Using cached record of: tidal://song/26284836 Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::play index undefined Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::startPlaybackTimer Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: [1765033587838] ControllerTidal::clearAddPlayTrack Dec 06 16:06:27 volumio volumio[1211]: info: Getting stream with soundQuality HI_RES Dec 06 16:06:27 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:27 volumio sudo[27400]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:27 volumio sudo[27400]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:27 volumio volumio[1211]: info: Dec 06 16:06:27 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:27 volumio volumio[1211]: info: sendMpdCommand stop took 69 milliseconds Dec 06 16:06:27 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:27 volumio volumio[1211]: info: Dec 06 16:06:27 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:27 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:27 volumio volumio[1211]: info: sendMpdCommand status took 3 milliseconds Dec 06 16:06:27 volumio volumio[1211]: info: sendMpdCommand status took 2 milliseconds Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:27 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 06 16:06:27 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:27 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:27 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:27 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:27 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:27 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:27 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:27 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:27 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:27 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:27 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:27 volumio volumio[1211]: info: ------------------------------ 42ms Dec 06 16:06:27 volumio volumio[1211]: info: ------------------------------ 42ms Dec 06 16:06:27 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:27 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:27 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 06 16:06:27 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 06 16:06:27 volumio sudo[27406]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:27 volumio sudo[27406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:27 volumio volumio[1211]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 06 16:06:27 volumio sudo[27410]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:27 volumio sudo[27410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:28 volumio volumio[1211]: info: getStreamUrl took 215 milliseconds Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand stop took 6 milliseconds Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:28 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand clear took 2 milliseconds Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic0NWJjMzkwYjBiZGJiYjRlYWJiOWUzZTgwZmE3NWU3M182MS5tcDQ/0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==" Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:28 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:28 volumio volumio[1211]: error: updateQueue error: null Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:28 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 3ms Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic0NWJjMzkwYjBiZGJiYjRlYWJiOWUzZTgwZmE3NWU3M182MS5tcDQ/0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==" took 3 milliseconds Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 2ms Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand play Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:28 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 3ms Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand play took 2 milliseconds Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 3ms Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand status took 55 milliseconds Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:28 volumio volumio[1211]: info: Dec 06 16:06:28 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand status took 60 milliseconds Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand status took 8 milliseconds Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand status took 7 milliseconds Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:28 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:28 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":349,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic0NWJjMzkwYjBiZGJiYjRlYWJiOWUzZTgwZmE3NWU3M182MS5tcDQ/0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","trackType":"tidal"} Dec 06 16:06:28 volumio volumio[1211]: verbose: CURRENT POSITION 0 Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus stop Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:28 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:28 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":349,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic0NWJjMzkwYjBiZGJiYjRlYWJiOWUzZTgwZmE3NWU3M182MS5tcDQ/0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","trackType":"tidal"} Dec 06 16:06:28 volumio volumio[1211]: verbose: CURRENT POSITION 0 Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:28 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:28 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 06 16:06:28 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:28 volumio systemd[1]: peppymeterbasic.service: Consumed 3.240s CPU time. Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 108ms Dec 06 16:06:28 volumio sudo[27400]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 135ms Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 72 milliseconds Dec 06 16:06:28 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 72 milliseconds Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:28 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:28 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:28 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":349,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic0NWJjMzkwYjBiZGJiYjRlYWJiOWUzZTgwZmE3NWU3M182MS5tcDQ/0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","trackType":"tidal"} Dec 06 16:06:28 volumio volumio[1211]: verbose: CURRENT POSITION 0 Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:28 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:28 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:28 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:28 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":349,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic0NWJjMzkwYjBiZGJiYjRlYWJiOWUzZTgwZmE3NWU3M182MS5tcDQ/0.flac?token=1765036988~NTk0YzM3MTg5YzJlMTJhZDY3YzhiZWUwOWZlZjNhZmIwZDk3MjUyZg==","trackType":"tidal"} Dec 06 16:06:28 volumio volumio[1211]: verbose: CURRENT POSITION 0 Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:28 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:28 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:28 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:28 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:28 volumio sudo[27410]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 163ms Dec 06 16:06:28 volumio volumio[1211]: info: ------------------------------ 164ms Dec 06 16:06:28 volumio sudo[27406]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:28 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:28 volumio sudo[27427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:28 volumio sudo[27427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:28 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:28 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:28 volumio sudo[27430]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:28 volumio sudo[27430]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:28 volumio sudo[27435]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:28 volumio sudo[27435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:28 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:28 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:28 volumio sudo[27427]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:28 volumio sudo[27435]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio sudo[27443]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:28 volumio sudo[27443]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:28 volumio sudo[27430]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio sudo[27439]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:28 volumio sudo[27439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:28 volumio sudo[27447]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:28 volumio sudo[27447]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:28 volumio sudo[27447]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio sudo[27443]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio sudo[27439]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:28 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:29 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 06 16:06:29 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 06 16:06:30 volumio volumio[27441]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:06:30 volumio volumio[27441]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:06:35 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::ClearQueue Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::stPlaybackTimer Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::serviceStop Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 0 Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::serviceStop Dec 06 16:06:35 volumio volumio[1211]: info: [1765033595142] ControllerTidal::stop Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::stop Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::clearPlayQueue Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:35 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/2571072 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/2571072 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875394 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/3875394 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875469 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/3875469 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/79636534 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/79636534 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3717973 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/3717973 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/22355053 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/22355053 Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPlay Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::play index 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:35 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665930 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/162665930 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/93327370 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/93327370 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/30055691 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/30055691 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3749626 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/3749626 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/64325809 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/64325809 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/458663828 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/458663828 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665824 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/162665824 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/168418438 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/168418438 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/154984887 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/154984887 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/5001181 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/5001181 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/35740418 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/35740418 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/14131695 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/14131695 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284797 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/26284797 Dec 06 16:06:35 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284836 Dec 06 16:06:35 volumio volumio[1211]: info: Using cached record of: tidal://song/26284836 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::play index undefined Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::startPlaybackTimer Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: [1765033595160] ControllerTidal::clearAddPlayTrack Dec 06 16:06:35 volumio volumio[1211]: info: Getting stream with soundQuality HI_RES Dec 06 16:06:35 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand stop took 57 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand status took 3 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand status took 2 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:35 volumio sudo[27490]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:35 volumio sudo[27490]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 35ms Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 33ms Dec 06 16:06:35 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:35 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 06 16:06:35 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:35 volumio sudo[27495]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:35 volumio sudo[27495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:35 volumio volumio[1211]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 06 16:06:35 volumio sudo[27498]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:35 volumio sudo[27498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:35 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 06 16:06:35 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:35 volumio systemd[1]: peppymeterbasic.service: Consumed 6.159s CPU time. Dec 06 16:06:35 volumio sudo[27490]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:35 volumio sudo[27495]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:35 volumio sudo[27498]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:35 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:35 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:35 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:35 volumio volumio[1211]: info: getStreamUrl took 577 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand stop took 1 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:35 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand clear took 0 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic2ZjMzOGQ2MDY5N2I3NzMwNTAwZDY1NmQ0ODkwNGE0ZV82MS5tcDQ/0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==" Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:35 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:35 volumio volumio[1211]: error: updateQueue error: null Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:35 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 2ms Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic2ZjMzOGQ2MDY5N2I3NzMwNTAwZDY1NmQ0ODkwNGE0ZV82MS5tcDQ/0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==" took 1 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 1ms Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand play Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:35 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 2ms Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand play took 2 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 1ms Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand status took 45 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:35 volumio volumio[1211]: info: Dec 06 16:06:35 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand status took 46 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand status took 1 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":389,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic2ZjMzOGQ2MDY5N2I3NzMwNTAwZDY1NmQ0ODkwNGE0ZV82MS5tcDQ/0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","trackType":"tidal"} Dec 06 16:06:35 volumio volumio[1211]: verbose: CURRENT POSITION 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus stop Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 54ms Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand status took 6 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":389,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1017 Kbps","isStreaming":false,"title":"0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic2ZjMzOGQ2MDY5N2I3NzMwNTAwZDY1NmQ0ODkwNGE0ZV82MS5tcDQ/0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","trackType":"tidal"} Dec 06 16:06:35 volumio volumio[1211]: verbose: CURRENT POSITION 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:35 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":389,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1229 Kbps","isStreaming":false,"title":"0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic2ZjMzOGQ2MDY5N2I3NzMwNTAwZDY1NmQ0ODkwNGE0ZV82MS5tcDQ/0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","trackType":"tidal"} Dec 06 16:06:35 volumio volumio[1211]: verbose: CURRENT POSITION 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:35 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 75ms Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 32ms Dec 06 16:06:35 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 06 16:06:35 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:35 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:35 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:35 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":389,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1132 Kbps","isStreaming":false,"title":"0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic2ZjMzOGQ2MDY5N2I3NzMwNTAwZDY1NmQ0ODkwNGE0ZV82MS5tcDQ/0.flac?token=1765037195~YTUyYTdiMmQxYzA4ZmRlNjNiMTQ2ZDMyMDQ2Yzk5OGVkNDFjNDBiZQ==","trackType":"tidal"} Dec 06 16:06:35 volumio volumio[1211]: verbose: CURRENT POSITION 5 Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:35 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:35 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:35 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:35 volumio volumio[1211]: info: ------------------------------ 47ms Dec 06 16:06:35 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:35 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:35 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:35 volumio sudo[27504]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:35 volumio sudo[27504]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:36 volumio sudo[27507]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:36 volumio sudo[27507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:36 volumio sudo[27508]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:36 volumio sudo[27508]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:36 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:36 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:36 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:36 volumio sudo[27513]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:36 volumio sudo[27513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:36 volumio sudo[27515]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:36 volumio sudo[27515]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:36 volumio sudo[27518]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:36 volumio sudo[27518]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:36 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:36 volumio sudo[27504]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:36 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:36 volumio sudo[27507]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:36 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:36 volumio sudo[27508]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:36 volumio sudo[27515]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:36 volumio sudo[27518]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:36 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:36 volumio sudo[27513]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:36 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:36 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:36 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:37 volumio volumio[27523]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:06:37 volumio volumio[27523]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:06:47 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::ClearQueue Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::stPlaybackTimer Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:47 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:47 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::serviceStop Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 5 Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::serviceStop Dec 06 16:06:47 volumio volumio[1211]: info: [1765033607579] ControllerTidal::stop Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:47 volumio volumio[1211]: info: ControllerMpd::stop Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::clearPlayQueue Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:47 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/2571072 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/2571072 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875394 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/3875394 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3875469 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/3875469 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/79636534 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/79636534 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3717973 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/3717973 Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioPlay Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::play index 4 Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::addQueueItems Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::addQueueItems Dec 06 16:06:47 volumio volumio[1211]: info: Preload queue cleared Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/22355053 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/22355053 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665930 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/162665930 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/93327370 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/93327370 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/30055691 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/30055691 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/3749626 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/3749626 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/64325809 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/64325809 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/458663828 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/458663828 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/162665824 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/162665824 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/168418438 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/168418438 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/154984887 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/154984887 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/5001181 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/5001181 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/35740418 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/35740418 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/14131695 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/14131695 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284797 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/26284797 Dec 06 16:06:47 volumio volumio[1211]: info: Adding Item to queue: tidal://song/26284836 Dec 06 16:06:47 volumio volumio[1211]: info: Using cached record of: tidal://song/26284836 Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::stop Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioPushQueue Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::saveQueue Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::play index undefined Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::updateTrackBlock Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrackBlock Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::startPlaybackTimer Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio volumio[1211]: info: [1765033607613] ControllerTidal::clearAddPlayTrack Dec 06 16:06:47 volumio volumio[1211]: info: Getting stream with soundQuality HI_RES Dec 06 16:06:47 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:47 volumio volumio[1211]: info: Dec 06 16:06:47 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:47 volumio volumio[1211]: info: sendMpdCommand stop took 67 milliseconds Dec 06 16:06:47 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:47 volumio volumio[1211]: info: Dec 06 16:06:47 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:47 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:47 volumio volumio[1211]: info: sendMpdCommand status took 2 milliseconds Dec 06 16:06:47 volumio volumio[1211]: info: sendMpdCommand status took 2 milliseconds Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:47 volumio sudo[27553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:47 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 06 16:06:47 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:47 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:47 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio sudo[27553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:47 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:47 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:47 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:47 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:47 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:47 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:47 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:47 volumio volumio[1211]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Dec 06 16:06:47 volumio volumio[1211]: info: ------------------------------ 44ms Dec 06 16:06:47 volumio volumio[1211]: info: ------------------------------ 43ms Dec 06 16:06:47 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 06 16:06:47 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:47 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 06 16:06:47 volumio volumio[1211]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 06 16:06:47 volumio sudo[27558]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:47 volumio sudo[27558]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:47 volumio sudo[27560]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 06 16:06:47 volumio sudo[27560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:47 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 06 16:06:47 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:47 volumio systemd[1]: peppymeterbasic.service: Consumed 11.217s CPU time. Dec 06 16:06:47 volumio sudo[27558]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:47 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:47 volumio sudo[27560]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:47 volumio sudo[27553]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:47 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:47 volumio volumio[1211]: info: peppymeterbasic Daemon Stop Dec 06 16:06:48 volumio volumio[1211]: info: getStreamUrl took 520 milliseconds Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand stop Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand stop took 0 milliseconds Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand clear Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:48 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand clear took 0 milliseconds Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==" Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:48 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:48 volumio volumio[1211]: error: updateQueue error: null Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:48 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 2ms Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==" took 2 milliseconds Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 1ms Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand play Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces system playlist update Dec 06 16:06:48 volumio volumio[1211]: info: Ignoring MPD Status Update Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 3ms Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand play took 2 milliseconds Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 1ms Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand status took 41 milliseconds Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:48 volumio volumio[1211]: info: Dec 06 16:06:48 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand status took 41 milliseconds Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand status took 1 milliseconds Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:48 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:48 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:06:48 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus stop Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 45ms Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand status took 3 milliseconds Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:48 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:48 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"700 Kbps","isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:06:48 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:48 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:48 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:48 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:06:48 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:48 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 65ms Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 26ms Dec 06 16:06:48 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 06 16:06:48 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:06:48 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:06:48 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:06:48 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:06:48 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:06:48 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:48 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:06:48 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:06:48 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:06:48 volumio volumio[1211]: info: ------------------------------ 39ms Dec 06 16:06:48 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:48 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:48 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:48 volumio sudo[27566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:48 volumio sudo[27566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:48 volumio sudo[27568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:48 volumio sudo[27568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:48 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:48 volumio sudo[27571]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:48 volumio sudo[27571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:48 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:48 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:06:48 volumio sudo[27576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:48 volumio sudo[27576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:48 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 06 16:06:48 volumio sudo[27578]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:48 volumio sudo[27578]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:48 volumio sudo[27566]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:48 volumio sudo[27584]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:06:48 volumio sudo[27584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:06:48 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:48 volumio sudo[27568]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:48 volumio sudo[27578]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:48 volumio sudo[27576]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:48 volumio sudo[27571]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:48 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:48 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:48 volumio sudo[27584]: pam_unix(sudo:session): session closed for user root Dec 06 16:06:48 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:48 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:48 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:06:50 volumio volumio[27587]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:06:50 volumio volumio[27587]: libpng warning: iCCP: known incorrect sRGB profile Dec 06 16:07:07 volumio volumio[1211]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 16:07:07 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 06 16:07:07 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 06 16:07:07 volumio sudo[27640]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 06 16:07:07 volumio sudo[27640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:07 volumio sudo[27640]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:07 volumio sudo[27645]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 06 16:07:07 volumio sudo[27645]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:07 volumio sudo[27653]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 06 16:07:07 volumio sudo[27645]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:07 volumio sudo[27653]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:07 volumio sudo[27653]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:07 volumio sudo[27658]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 06 16:07:07 volumio sudo[27658]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:07 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 06 16:07:07 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 06 16:07:07 volumio sudo[27658]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:07 volumio sudo[27665]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 06 16:07:07 volumio sudo[27665]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:07 volumio sudo[27665]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:07 volumio sudo[27668]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 16:07:07 volumio sudo[27668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:07 volumio sudo[27668]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:07 volumio sudo[27671]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 06 16:07:07 volumio sudo[27671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:10 volumio sudo[27671]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:16 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 06 16:07:16 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 06 16:07:16 volumio sudo[27692]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 06 16:07:16 volumio sudo[27692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:19 volumio sudo[27692]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioSeek Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::seek Dec 06 16:07:42 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:42 volumio volumio[1211]: info: TRACKBLOCK {"album":"How Do I Look","albumUri":"tidal://album/3717959","albumart":"https://resources.tidal.com/images/7586087d/e7cc/4d8c/b669/4c11b593aed5/640x640.jpg","artist":"Saga","artistUri":"tidal://artist/34483","audioQuality":"LOSSLESS","bitdepth":"16 bit","duration":351,"explicit":false,"name":"Wind Him Up","samplerate":"44.1 KHz","service":"tidal","title":"Wind Him Up","trackType":"tidal","tracknumber":14,"type":"track","uri":"tidal://song/3717973","volumeNumber":1} Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::startPlaybackTimer Dec 06 16:07:42 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:42 volumio volumio[1211]: info: [1765033662576] ControllerTidal::seek Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:07:42 volumio volumio[1211]: info: ControllerMpd::seek Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:42 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:42 volumio volumio[1211]: error: null Dec 06 16:07:42 volumio volumio[1211]: info: Dec 06 16:07:42 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:07:42 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:07:42 volumio volumio[1211]: info: Dec 06 16:07:42 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:07:42 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:07:42 volumio sudo[27744]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:42 volumio volumio[1211]: info: sendMpdCommand status took 11 milliseconds Dec 06 16:07:42 volumio volumio[1211]: info: sendMpdCommand status took 8 milliseconds Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:07:42 volumio sudo[27744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:42 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 06 16:07:42 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:07:42 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:07:42 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:07:42 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:42 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":168100,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1062 Kbps","isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:07:42 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:07:42 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:42 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:07:42 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:42 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":168100,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1062 Kbps","isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:07:42 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:07:42 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:42 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:42 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:42 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:42 volumio volumio[1211]: info: ------------------------------ 56ms Dec 06 16:07:42 volumio volumio[1211]: info: ------------------------------ 56ms Dec 06 16:07:42 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:42 volumio sudo[27744]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:42 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:42 volumio sudo[27747]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:42 volumio sudo[27747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:42 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:42 volumio sudo[27749]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:42 volumio sudo[27749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:42 volumio sudo[27753]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:42 volumio sudo[27753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:42 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:42 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:42 volumio sudo[27756]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:42 volumio sudo[27756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:42 volumio sudo[27753]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:42 volumio sudo[27749]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:42 volumio sudo[27747]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:42 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:42 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:42 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:42 volumio sudo[27756]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:42 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioSeek Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::seek Dec 06 16:07:45 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:45 volumio volumio[1211]: info: TRACKBLOCK {"album":"How Do I Look","albumUri":"tidal://album/3717959","albumart":"https://resources.tidal.com/images/7586087d/e7cc/4d8c/b669/4c11b593aed5/640x640.jpg","artist":"Saga","artistUri":"tidal://artist/34483","audioQuality":"LOSSLESS","bitdepth":"16 bit","duration":351,"explicit":false,"name":"Wind Him Up","samplerate":"44.1 KHz","service":"tidal","title":"Wind Him Up","trackType":"tidal","tracknumber":14,"type":"track","uri":"tidal://song/3717973","volumeNumber":1} Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::startPlaybackTimer Dec 06 16:07:45 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:45 volumio volumio[1211]: info: [1765033665757] ControllerTidal::seek Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 06 16:07:45 volumio volumio[1211]: info: ControllerMpd::seek Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:45 volumio volumio[1211]: error: null Dec 06 16:07:45 volumio volumio[1211]: info: Dec 06 16:07:45 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:07:45 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:07:45 volumio volumio[1211]: info: Dec 06 16:07:45 volumio volumio[1211]: ---------------------------- MPD announces state update: player Dec 06 16:07:45 volumio volumio[1211]: info: ControllerMpd::getState Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand status Dec 06 16:07:45 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:45 volumio volumio[1211]: info: sendMpdCommand status took 26 milliseconds Dec 06 16:07:45 volumio volumio[1211]: info: sendMpdCommand status took 26 milliseconds Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::parseState Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 06 16:07:45 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 16:07:45 volumio volumio[1211]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:07:45 volumio volumio[1211]: verbose: ControllerMpd::parseTrackInfo Dec 06 16:07:45 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:07:45 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:45 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":84100,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"994 Kbps","isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:07:45 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:07:45 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:45 volumio volumio[1211]: info: ControllerMpd::pushState Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::servicePushState Dec 06 16:07:45 volumio volumio[1211]: info: CorePlayQueue::getTrack 4 Dec 06 16:07:45 volumio volumio[1211]: verbose: STATE SERVICE {"status":"play","position":0,"seek":84100,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"930 Kbps","isStreaming":false,"title":"0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicxZjI1YjY1ZjBlOTUxYjdjY2YzNzljMjZiNjkwYTAwY182MS5tcDQ/0.flac?token=1765037208~ZTAwNGJjYzkwMDkyY2EzMmVlYjM4YjFjZGI1MDY4ZDEyMDBlZjdhNA==","trackType":"tidal"} Dec 06 16:07:45 volumio volumio[1211]: verbose: CURRENT POSITION 4 Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::syncState stateService play Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::syncState currentStatus play Dec 06 16:07:45 volumio volumio[1211]: info: Received an update from plugin. extracting info from payload Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:45 volumio volumio[1211]: info: CoreStateMachine::pushState Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioPushState Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output update for this device Dec 06 16:07:45 volumio volumio[1211]: info: MRS: Pushing multiroomSync output Dec 06 16:07:45 volumio volumio[1211]: info: CoreCommandRouter::volumioGetState Dec 06 16:07:45 volumio sudo[27759]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:45 volumio sudo[27759]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:45 volumio volumio[1211]: info: ------------------------------ 63ms Dec 06 16:07:45 volumio volumio[1211]: info: ------------------------------ 63ms Dec 06 16:07:45 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:45 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:45 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:45 volumio sudo[27762]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:45 volumio sudo[27762]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:45 volumio sudo[27765]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:45 volumio sudo[27765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:45 volumio sudo[27759]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:45 volumio sudo[27766]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:45 volumio sudo[27766]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:45 volumio volumio[1211]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 06 16:07:45 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:45 volumio sudo[27765]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:45 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:45 volumio sudo[27766]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:45 volumio sudo[27762]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:45 volumio sudo[27771]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 06 16:07:45 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:45 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:45 volumio sudo[27771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:45 volumio sudo[27771]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:46 volumio volumio[1211]: info: peppymeterbasic Daemon Started Dec 06 16:07:49 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Dec 06 16:07:49 volumio volumio[1211]: info: Saving new wireless network Dec 06 16:07:49 volumio sudo[27792]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Dec 06 16:07:49 volumio sudo[27792]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:49 volumio sudo[27792]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:49 volumio volumio[1211]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 06 16:07:49 volumio volumio[1211]: info: Discovery: Restarting Advertising due to device name change Dec 06 16:07:49 volumio sudo[27796]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 06 16:07:49 volumio sudo[27796]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:49 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 06 16:07:49 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 06 16:07:49 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 06 16:07:49 volumio systemd[1]: wireless.service: Consumed 7min 21.506s CPU time. Dec 06 16:07:49 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 06 16:07:50 volumio wireless.js[27802]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 06 16:07:50 volumio wireless.js[27802]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 06 16:07:50 volumio wireless.js[27802]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 06 16:07:50 volumio wireless.js[27802]: WIRELESS.JS: Cleaning previous... Dec 06 16:07:50 volumio sudo[27820]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 06 16:07:50 volumio sudo[27820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 16:07:50 volumio sudo[27820]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:50 volumio sudo[27822]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 06 16:07:50 volumio sudo[27822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 16:07:50 volumio volumio[1211]: info: Discovery: A device disappeared from network Dec 06 16:07:50 volumio volumio[1211]: info: Discovery: Device volumio disappeared from network Dec 06 16:07:50 volumio volumio[1211]: info: Discovery: A device disappeared from network Dec 06 16:07:51 volumio sudo[27822]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:51 volumio sudo[27825]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 16:07:51 volumio sudo[27825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:51 volumio sudo[27825]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:51 volumio wireless.js[27802]: WIRELESS.JS: Stopped aP Dec 06 16:07:51 volumio sudo[27833]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 06 16:07:51 volumio sudo[27833]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:51 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 06 16:07:51 volumio sudo[27833]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:51 volumio sudo[27835]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 06 16:07:51 volumio sudo[27835]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:51 volumio sudo[27835]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:51 volumio sudo[27843]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 06 16:07:51 volumio sudo[27843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:51 volumio sudo[27843]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:51 volumio sudo[27845]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 06 16:07:51 volumio sudo[27845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:51 volumio sudo[27850]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 16:07:51 volumio sudo[27850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:51 volumio sudo[27850]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:52 volumio sudo[27853]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 16:07:52 volumio sudo[27853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:52 volumio sudo[27853]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:53 volumio sudo[27856]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 16:07:53 volumio sudo[27856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:53 volumio sudo[27856]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:53 volumio sudo[27845]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:53 volumio wireless.js[27802]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: DK Dec 06 16:07:53 volumio sudo[27860]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 06 16:07:53 volumio sudo[27860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:53 volumio sudo[27860]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:53 volumio sudo[27862]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DK Dec 06 16:07:53 volumio sudo[27862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:54 volumio sudo[27862]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:54 volumio wireless.js[27802]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: DK Dec 06 16:07:54 volumio wireless.js[27802]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Dec 06 16:07:54 volumio wireless.js[27802]: WIRELESS.JS: Notified systemd about wireless ready Dec 06 16:07:54 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 06 16:07:54 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 06 16:07:54 volumio sudo[27796]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:54 volumio volumio[1211]: info: Discovery: Started advertising with name: Volumio Dec 06 16:07:54 volumio sudo[27870]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 16:07:54 volumio sudo[27870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 16:07:54 volumio sudo[27870]: pam_unix(sudo:session): session closed for user root Dec 06 16:07:55 volumio volumio[1211]: compat.c: read() failed: Resource temporarily unavailable Dec 06 16:07:55 volumio volumio[1211]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 16:07:55 volumio volumio[1211]: Error: dns service error: unknown Dec 06 16:07:55 volumio volumio[1211]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 06 16:07:55 volumio volumio[1211]: errorCode: -65537 Dec 06 16:07:55 volumio volumio[1211]: } Dec 06 16:07:55 volumio volumio[1211]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 16:07:56 volumio sudo[27888]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-06 16:06' Dec 06 16:07:56 volumio sudo[27888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 2 11:51:19 UTC 2025" VOLUMIO_VERSION="4.072" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e5001581b220b096097cf8f46a54d4f1"