-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-11-02 17:52:06 CET. -- Nov 02 17:51:02 volumio volumio[1260]: error: updateQueue error: null Nov 02 17:51:02 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand add "http://ice5.abradio.cz/beat128.mp3" Nov 02 17:51:02 volumio volumio[1260]: info: ------------------------------ 5697ms Nov 02 17:51:02 volumio volumio[1260]: info: Nov 02 17:51:02 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Nov 02 17:51:02 volumio volumio[1260]: info: Ignoring MPD Status Update Nov 02 17:51:02 volumio volumio[1260]: info: sendMpdCommand add "http://ice5.abradio.cz/beat128.mp3" took 2 milliseconds Nov 02 17:51:02 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 17:51:02 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand play Nov 02 17:51:02 volumio volumio[1260]: info: ------------------------------ 7ms Nov 02 17:51:02 volumio volumio[1260]: info: sendMpdCommand play took 7 milliseconds Nov 02 17:51:02 volumio volumio[1260]: info: Nov 02 17:51:02 volumio volumio[1260]: ---------------------------- MPD announces state update: player Nov 02 17:51:03 volumio volumio[1260]: info: ControllerMpd::getState Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Nov 02 17:51:03 volumio volumio[1260]: info: Nov 02 17:51:03 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Nov 02 17:51:03 volumio volumio[1260]: info: Ignoring MPD Status Update Nov 02 17:51:03 volumio volumio[1260]: info: Nov 02 17:51:03 volumio volumio[1260]: ---------------------------- MPD announces state update: player Nov 02 17:51:03 volumio volumio[1260]: info: ControllerMpd::getState Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Nov 02 17:51:03 volumio volumio[1260]: info: Nov 02 17:51:03 volumio volumio[1260]: ---------------------------- MPD announces system playlist update Nov 02 17:51:03 volumio volumio[1260]: info: Ignoring MPD Status Update Nov 02 17:51:03 volumio volumio[1260]: info: Nov 02 17:51:03 volumio volumio[1260]: ---------------------------- MPD announces state update: player Nov 02 17:51:03 volumio volumio[1260]: info: sendMpdCommand status took 13 milliseconds Nov 02 17:51:03 volumio volumio[1260]: info: ControllerMpd::getState Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status Nov 02 17:51:03 volumio volumio[1260]: info: ------------------------------ 13ms Nov 02 17:51:03 volumio volumio[1260]: info: sendMpdCommand status took 10 milliseconds Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::parseState Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::parseState Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 17:51:03 volumio volumio[1260]: info: ------------------------------ 16ms Nov 02 17:51:03 volumio volumio[1260]: info: sendMpdCommand status took 10 milliseconds Nov 02 17:51:03 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 17:51:03 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::parseState Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Nov 02 17:51:03 volumio volumio[1260]: info: ControllerMpd::pushState Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Nov 02 17:51:03 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:03 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":866,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"YES - Close To The Edge","artist":"RADIO BEAT","album":null,"uri":"http://ice5.abradio.cz/beat128.mp3","trackType":"mp3"} Nov 02 17:51:03 volumio volumio[1260]: verbose: CURRENT POSITION 0 Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus stop Nov 02 17:51:03 volumio volumio[1260]: info: ControllerMpd::pushState Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Nov 02 17:51:03 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:03 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1232,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"YES - Close To The Edge","artist":"RADIO BEAT","album":null,"uri":"http://ice5.abradio.cz/beat128.mp3","trackType":"mp3"} Nov 02 17:51:03 volumio volumio[1260]: verbose: CURRENT POSITION 0 Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Nov 02 17:51:03 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:03 volumio volumio[1260]: info: ------------------------------ 115ms Nov 02 17:51:03 volumio volumio[1260]: info: ------------------------------ 139ms Nov 02 17:51:03 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 116 milliseconds Nov 02 17:51:03 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo Nov 02 17:51:03 volumio volumio[1260]: info: ControllerMpd::pushState Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::servicePushState Nov 02 17:51:03 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:03 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1232,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"YES - Close To The Edge","artist":"RADIO BEAT","album":null,"uri":"http://ice5.abradio.cz/beat128.mp3","trackType":"mp3"} Nov 02 17:51:03 volumio volumio[1260]: verbose: CURRENT POSITION 0 Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play Nov 02 17:51:03 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:03 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:03 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:03 volumio volumio[1260]: info: ------------------------------ 316ms Nov 02 17:51:03 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status play Nov 02 17:51:03 volumio sudo[2338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Nov 02 17:51:03 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status play Nov 02 17:51:03 volumio sudo[2338]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:03 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status play Nov 02 17:51:03 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status play Nov 02 17:51:03 volumio sudo[2341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Nov 02 17:51:03 volumio sudo[2341]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:03 volumio systemd[1]: Started peppymeterbasic Daemon. Nov 02 17:51:03 volumio sudo[2338]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:03 volumio sudo[2344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Nov 02 17:51:03 volumio sudo[2344]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:03 volumio sudo[2347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Nov 02 17:51:03 volumio sudo[2347]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:03 volumio sudo[2341]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:03 volumio sudo[2347]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:03 volumio volumio[1260]: info: peppymeterbasic Daemon Started Nov 02 17:51:03 volumio sudo[2344]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:03 volumio volumio[1260]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 17:51:04 volumio volumio[1260]: info: peppymeterbasic Daemon Started Nov 02 17:51:04 volumio volumio[1260]: info: peppymeterbasic Daemon Started Nov 02 17:51:07 volumio volumio[2343]: libpng warning: iCCP: known incorrect sRGB profile Nov 02 17:51:08 volumio volumio[2343]: libpng warning: iCCP: known incorrect sRGB profile Nov 02 17:51:08 volumio volumio[2343]: libpng warning: iCCP: known incorrect sRGB profile Nov 02 17:51:12 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 02 17:51:12 volumio volumio[1260]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 02 17:51:12 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 02 17:51:12 volumio volumio[1260]: info: Received Get System Version Nov 02 17:51:12 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 02 17:51:12 volumio volumio[1260]: info: Received Get System Info Nov 02 17:51:12 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 17:51:12 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 17:51:12 volumio volumio[1260]: info: Discovery: Getting this device information Nov 02 17:51:12 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Nov 02 17:51:12 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 17:51:13 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 17:51:13 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 17:51:13 volumio volumio[1260]: info: Discovery: Getting this device information Nov 02 17:51:13 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Nov 02 17:51:13 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 17:51:15 volumio volumio[1260]: info: CoreCommandRouter::volumioStop Nov 02 17:51:15 volumio volumio[1260]: info: CoreStateMachine::stop Nov 02 17:51:15 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:15 volumio volumio[1260]: info: CoreStateMachine::stPlaybackTimer Nov 02 17:51:15 volumio volumio[1260]: info: CoreStateMachine::updateTrackBlock Nov 02 17:51:15 volumio volumio[1260]: info: CorePlayQueue::getTrackBlock Nov 02 17:51:15 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:15 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:15 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 17:51:15 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:15 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:15 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:15 volumio volumio[1260]: info: CoreStateMachine::serviceStop Nov 02 17:51:15 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:15 volumio volumio[1260]: info: CoreCommandRouter::serviceStop Nov 02 17:51:15 volumio volumio[1260]: info: [1762102275330] ControllerWebradio::stop Nov 02 17:51:15 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 17:51:15 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status stop Nov 02 17:51:15 volumio sudo[2383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Nov 02 17:51:15 volumio volumio[1260]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 02 17:51:15 volumio sudo[2383]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:15 volumio systemd[1]: Stopping peppymeterbasic Daemon... Nov 02 17:51:15 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Nov 02 17:51:15 volumio volumio[1260]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 17:51:15 volumio systemd[1]: peppymeterbasic.service: Succeeded. Nov 02 17:51:15 volumio systemd[1]: Stopped peppymeterbasic Daemon. Nov 02 17:51:15 volumio sudo[2383]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:15 volumio volumio[1260]: info: peppymeterbasic Daemon Stop Nov 02 17:51:22 volumio volumio[1260]: info: VolumeController::SetAlsaVolume95 Nov 02 17:51:22 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:22 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:22 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 17:51:22 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:22 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:22 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:22 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status stop Nov 02 17:51:22 volumio sudo[2389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Nov 02 17:51:22 volumio sudo[2389]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:22 volumio sudo[2389]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:22 volumio volumio[1260]: info: peppymeterbasic Daemon Stop Nov 02 17:51:22 volumio volumio[1260]: info: VolumeController::SetAlsaVolume100 Nov 02 17:51:22 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:22 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:22 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 17:51:22 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:22 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:22 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:22 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status stop Nov 02 17:51:22 volumio sudo[2393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Nov 02 17:51:22 volumio sudo[2393]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:22 volumio sudo[2393]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:22 volumio volumio[1260]: info: peppymeterbasic Daemon Stop Nov 02 17:51:22 volumio volumio[1260]: info: VolumeController::SetAlsaVolume104 Nov 02 17:51:22 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:22 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:22 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:22 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:22 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:23 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status stop Nov 02 17:51:23 volumio sudo[2397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Nov 02 17:51:23 volumio sudo[2397]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:23 volumio sudo[2397]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:23 volumio volumio[1260]: info: peppymeterbasic Daemon Stop Nov 02 17:51:23 volumio volumio[1260]: info: VolumeController::SetAlsaVolume96 Nov 02 17:51:23 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:23 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:23 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 17:51:23 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:23 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:23 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:23 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status stop Nov 02 17:51:23 volumio sudo[2403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Nov 02 17:51:23 volumio sudo[2403]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:23 volumio sudo[2403]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:23 volumio volumio[1260]: info: peppymeterbasic Daemon Stop Nov 02 17:51:24 volumio volumio[1260]: info: VolumeController::SetAlsaVolume81 Nov 02 17:51:24 volumio volumio[1260]: info: CoreStateMachine::pushState Nov 02 17:51:24 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:24 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 17:51:24 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState Nov 02 17:51:24 volumio volumio[1260]: info: MRS: Pushing multiroomSync output update for this device Nov 02 17:51:24 volumio volumio[1260]: info: MRS: Pushing multiroomSync output Nov 02 17:51:24 volumio volumio[1260]: info: PeppyMeterBasic ---peppymeterbasic status stop Nov 02 17:51:24 volumio sudo[2407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Nov 02 17:51:24 volumio sudo[2407]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:24 volumio sudo[2407]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:24 volumio volumio[1260]: info: peppymeterbasic Daemon Stop Nov 02 17:51:33 volumio mpd_monitor.sh[622]: MPD Monitor Service: MPD Appears to be inactive, restarting Nov 02 17:51:33 volumio systemd[1]: Stopping Music Player Daemon... Nov 02 17:51:33 volumio volumio[1260]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 17:51:37 volumio volumio[1260]: info: CoreCommandRouter::volumioGetQueue Nov 02 17:51:37 volumio volumio[1260]: info: CoreStateMachine::getQueue Nov 02 17:51:37 volumio volumio[1260]: info: CorePlayQueue::getQueue Nov 02 17:51:38 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Nov 02 17:51:38 volumio volumio[1260]: info: CoreStateMachine::play index 0 Nov 02 17:51:38 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:38 volumio volumio[1260]: info: CoreStateMachine::stop Nov 02 17:51:38 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:38 volumio volumio[1260]: info: CoreStateMachine::play index undefined Nov 02 17:51:38 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:38 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:38 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer Nov 02 17:51:38 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:38 volumio volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 17:51:38 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 17:51:38 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 02 17:51:38 volumio volumio[1260]: info: [1762102298822] ControllerWebradio::clearAddPlayTrack Nov 02 17:51:38 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 17:51:40 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Nov 02 17:51:40 volumio volumio[1260]: info: CoreStateMachine::play index 0 Nov 02 17:51:40 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:40 volumio volumio[1260]: info: CoreStateMachine::stop Nov 02 17:51:40 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:40 volumio volumio[1260]: info: CoreStateMachine::play index undefined Nov 02 17:51:40 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:40 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:40 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer Nov 02 17:51:40 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:40 volumio volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 17:51:40 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 17:51:40 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 02 17:51:40 volumio volumio[1260]: info: [1762102300781] ControllerWebradio::clearAddPlayTrack Nov 02 17:51:40 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 17:51:41 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Nov 02 17:51:41 volumio volumio[1260]: info: CoreStateMachine::play index 0 Nov 02 17:51:41 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:41 volumio volumio[1260]: info: CoreStateMachine::stop Nov 02 17:51:41 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:41 volumio volumio[1260]: info: CoreStateMachine::play index undefined Nov 02 17:51:41 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:41 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:41 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer Nov 02 17:51:41 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:41 volumio volumio[1260]: info: CoreCommandRouter::volumioGetVisibleSources Nov 02 17:51:41 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 02 17:51:41 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 02 17:51:41 volumio volumio[1260]: info: [1762102301944] ControllerWebradio::clearAddPlayTrack Nov 02 17:51:41 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 17:51:42 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem Nov 02 17:51:42 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem Nov 02 17:51:42 volumio volumio[1260]: info: CoreStateMachine::stop Nov 02 17:51:42 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:42 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 0 Nov 02 17:51:42 volumio volumio[1260]: info: CorePlayQueue::saveQueue Nov 02 17:51:42 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue Nov 02 17:51:43 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 02 17:51:43 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 02 17:51:43 volumio volumio[1260]: info: Discovery: Getting this device information Nov 02 17:51:43 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Nov 02 17:51:43 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:43 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 02 17:51:43 volumio volumio[1260]: info: sendMpdCommand stop took 28185 milliseconds Nov 02 17:51:43 volumio systemd[1]: mpd.service: Succeeded. Nov 02 17:51:43 volumio systemd[1]: Stopped Music Player Daemon. Nov 02 17:51:43 volumio volumio[1260]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 02 17:51:43 volumio systemd[1]: Starting Music Player Daemon... Nov 02 17:51:43 volumio volumio[1260]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 02 17:51:43 volumio sudo[2481]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 02 17:51:43 volumio sudo[2481]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 17:51:43 volumio sudo[2481]: pam_unix(sudo:session): session closed for user root Nov 02 17:51:46 volumio mpd[2483]: Nov 02 17:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 02 17:51:46 volumio systemd[1]: Started Music Player Daemon. Nov 02 17:51:46 volumio mpd_monitor.sh[622]: MPD Monitor Service: MPD restarted due to no mpc output. Nov 02 17:51:48 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Nov 02 17:51:48 volumio volumio[1260]: info: CoreStateMachine::play index undefined Nov 02 17:51:48 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:48 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:51:51 volumio volumio[1260]: info: CoreCommandRouter::volumioPlay Nov 02 17:51:51 volumio volumio[1260]: info: CoreStateMachine::play index undefined Nov 02 17:51:51 volumio volumio[1260]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 17:51:51 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:52:00 volumio volumio[1260]: verbose: New Socket.io Connection to 192.168.0.37 from 192.168.0.163 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Nov 02 17:52:00 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Nov 02 17:52:00 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:52:01 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 02 17:52:01 volumio volumio[1260]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 02 17:52:01 volumio volumio[1260]: info: Listing playlists Nov 02 17:52:01 volumio volumio[1260]: info: CoreCommandRouter::volumioGetQueue Nov 02 17:52:01 volumio volumio[1260]: info: CoreStateMachine::getQueue Nov 02 17:52:01 volumio volumio[1260]: info: CorePlayQueue::getQueue Nov 02 17:52:03 volumio volumio[1260]: verbose: New Socket.io Connection to 192.168.0.37 from 192.168.0.163 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Nov 02 17:52:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetState Nov 02 17:52:03 volumio volumio[1260]: info: CorePlayQueue::getTrack 0 Nov 02 17:52:03 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 02 17:52:03 volumio volumio[1260]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 02 17:52:03 volumio volumio[1260]: info: Listing playlists Nov 02 17:52:03 volumio volumio[1260]: info: CoreCommandRouter::volumioGetQueue Nov 02 17:52:03 volumio volumio[1260]: info: CoreStateMachine::getQueue Nov 02 17:52:03 volumio volumio[1260]: info: CorePlayQueue::getQueue Nov 02 17:52:05 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Nov 02 17:52:05 volumio volumio[1260]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Nov 02 17:52:05 volumio volumio[1260]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 17:52:05 volumio volumio[1260]: TypeError: Cannot read property 'then' of undefined Nov 02 17:52:05 volumio volumio[1260]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Nov 02 17:52:05 volumio volumio[1260]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Nov 02 17:52:05 volumio volumio[1260]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1456:26) Nov 02 17:52:05 volumio volumio[1260]: at Socket.emit (events.js:315:20) Nov 02 17:52:05 volumio volumio[1260]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 02 17:52:05 volumio volumio[1260]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 02 17:52:05 volumio volumio[1260]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 17:52:06 volumio sudo[2538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-02 17:51 Nov 02 17:52:06 volumio sudo[2538]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"