-- Logs begin at Tue 2025-07-08 13:46:41 +04, end at Tue 2025-07-08 14:02:18 +04. -- Jul 08 14:01:02 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:06 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:11 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:15 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:18 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:22 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:26 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:30 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:34 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:39 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:42 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:42 dubliners systemd[1]: Starting Cleanup of Temporary Directories... Jul 08 14:01:42 dubliners systemd-tmpfiles[4441]: [/usr/lib/tmpfiles.d/zabbix-agent.conf:1] Line references path below legacy directory /var/run/, updating /var/run/zabbix → /run/zabbix; please update the tmpfiles.d/ drop-in file accordingly. Jul 08 14:01:42 dubliners systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Jul 08 14:01:42 dubliners systemd[1]: Started Cleanup of Temporary Directories. Jul 08 14:01:46 dubliners volumio[3656]: info: VolumeController::SetAlsaVolume50 Jul 08 14:01:46 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:01:46 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:01:46 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 14:01:46 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:01:46 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:49 dubliners volumio[3656]: info: VolumeController::SetAlsaVolume45 Jul 08 14:01:49 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:01:49 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:01:49 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 14:01:49 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:01:50 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 14:01:54 dubliners volumio[3656]: info: CoreCommandRouter::volumioGetQueue Jul 08 14:01:54 dubliners volumio[3656]: info: CoreStateMachine::getQueue Jul 08 14:01:54 dubliners volumio[3656]: info: CorePlayQueue::getQueue Jul 08 14:01:57 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:01:57 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:01:57 dubliners volumio[3656]: info: Prefetching next song Jul 08 14:01:57 dubliners volumio[3656]: info: DOING PREFETCH IN MPD Jul 08 14:01:57 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/1 Daytime mix/Mirrorball Everything But the Girl.mp3" Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand add "INTERNAL/1 Daytime mix/Mirrorball Everything But the Girl.mp3" took 2196 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 08 14:02:00 dubliners volumio[3656]: info: Jul 08 14:02:00 dubliners volumio[3656]: ---------------------------- MPD announces system playlist update Jul 08 14:02:00 dubliners volumio[3656]: info: Ignoring MPD Status Update Jul 08 14:02:00 dubliners volumio[3656]: info: Jul 08 14:02:00 dubliners volumio[3656]: ---------------------------- MPD announces state update: options Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand consume 1 took 7 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: info: ControllerMpd::getState Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand status Jul 08 14:02:00 dubliners volumio[3656]: info: Jul 08 14:02:00 dubliners volumio[3656]: ---------------------------- MPD announces system playlist update Jul 08 14:02:00 dubliners volumio[3656]: info: Ignoring MPD Status Update Jul 08 14:02:00 dubliners volumio[3656]: info: Jul 08 14:02:00 dubliners volumio[3656]: ---------------------------- MPD announces system playlist update Jul 08 14:02:00 dubliners volumio[3656]: info: Ignoring MPD Status Update Jul 08 14:02:00 dubliners volumio[3656]: info: ------------------------------ 62ms Jul 08 14:02:00 dubliners volumio[3656]: info: Jul 08 14:02:00 dubliners volumio[3656]: ---------------------------- MPD announces state update: options Jul 08 14:02:00 dubliners volumio[3656]: info: ControllerMpd::getState Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand status Jul 08 14:02:00 dubliners volumio[3656]: info: Jul 08 14:02:00 dubliners volumio[3656]: ---------------------------- MPD announces state update: options Jul 08 14:02:00 dubliners volumio[3656]: info: ControllerMpd::getState Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand status Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand status took 83 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: info: ------------------------------ 82ms Jul 08 14:02:00 dubliners volumio[3656]: info: ------------------------------ 79ms Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand status took 14 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand status took 10 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::parseState Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::parseState Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::parseState Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::parseTrackInfo Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::parseTrackInfo Jul 08 14:02:00 dubliners volumio[3656]: verbose: ControllerMpd::parseTrackInfo Jul 08 14:02:00 dubliners volumio[3656]: info: ControllerMpd::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::servicePushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: verbose: STATE SERVICE {"status":"play","position":0,"seek":203483,"duration":206,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Pompeii (Live from Capitol Studios 2013)","artist":"Bastille","album":"Oblivion - EP","uri":"INTERNAL/1 Daytime mix/Pompeii (Live from Capitol Studios 2013) Bastille.mp3","trackType":"mp3"} Jul 08 14:02:00 dubliners volumio[3656]: verbose: CURRENT POSITION 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::syncState stateService play Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::syncState currentStatus play Jul 08 14:02:00 dubliners volumio[3656]: info: Received an update from plugin. extracting info from payload Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:00 dubliners volumio[3656]: info: ControllerMpd::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::servicePushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: verbose: STATE SERVICE {"status":"play","position":0,"seek":203483,"duration":206,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Pompeii (Live from Capitol Studios 2013)","artist":"Bastille","album":"Oblivion - EP","uri":"INTERNAL/1 Daytime mix/Pompeii (Live from Capitol Studios 2013) Bastille.mp3","trackType":"mp3"} Jul 08 14:02:00 dubliners volumio[3656]: verbose: CURRENT POSITION 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::syncState stateService play Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::syncState currentStatus play Jul 08 14:02:00 dubliners volumio[3656]: info: Received an update from plugin. extracting info from payload Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:00 dubliners volumio[3656]: info: ControllerMpd::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::servicePushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: verbose: STATE SERVICE {"status":"play","position":0,"seek":203483,"duration":206,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Pompeii (Live from Capitol Studios 2013)","artist":"Bastille","album":"Oblivion - EP","uri":"INTERNAL/1 Daytime mix/Pompeii (Live from Capitol Studios 2013) Bastille.mp3","trackType":"mp3"} Jul 08 14:02:00 dubliners volumio[3656]: verbose: CURRENT POSITION 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::syncState stateService play Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::syncState currentStatus play Jul 08 14:02:00 dubliners volumio[3656]: info: Received an update from plugin. extracting info from payload Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:00 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:00 dubliners volumio[3656]: info: CorePlayQueue::getTrack 1 Jul 08 14:02:00 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:00 dubliners volumio[3656]: info: ------------------------------ 225ms Jul 08 14:02:00 dubliners volumio[3656]: info: ------------------------------ 153ms Jul 08 14:02:00 dubliners volumio[3656]: info: ------------------------------ 150ms Jul 08 14:02:01 dubliners CRON[4484]: pam_unix(cron:session): session opened for user root by (uid=0) Jul 08 14:02:01 dubliners CRON[4485]: (root) CMD (/root/sycfm/bin/mp-sw.sh 1) Jul 08 14:02:02 dubliners volumio[3656]: info: CoreStateMachine::startPlaybackTimer Jul 08 14:02:02 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:02 dubliners volumio[3656]: info: Jul 08 14:02:02 dubliners volumio[3656]: ---------------------------- MPD announces system playlist update Jul 08 14:02:02 dubliners volumio[3656]: info: Ignoring MPD Status Update Jul 08 14:02:02 dubliners volumio[3656]: info: Jul 08 14:02:02 dubliners volumio[3656]: ---------------------------- MPD announces state update: player Jul 08 14:02:02 dubliners volumio[3656]: info: ControllerMpd::getState Jul 08 14:02:02 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand status Jul 08 14:02:02 dubliners volumio[3656]: info: Jul 08 14:02:02 dubliners volumio[3656]: ---------------------------- MPD announces system playlist update Jul 08 14:02:02 dubliners volumio[3656]: info: Ignoring MPD Status Update Jul 08 14:02:02 dubliners volumio[3656]: info: Jul 08 14:02:02 dubliners volumio[3656]: ---------------------------- MPD announces state update: player Jul 08 14:02:02 dubliners volumio[3656]: info: ControllerMpd::getState Jul 08 14:02:02 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand status Jul 08 14:02:03 dubliners volumio[3656]: info: Jul 08 14:02:03 dubliners volumio[3656]: ---------------------------- MPD announces system playlist update Jul 08 14:02:03 dubliners volumio[3656]: info: Ignoring MPD Status Update Jul 08 14:02:03 dubliners volumio[3656]: info: Jul 08 14:02:03 dubliners volumio[3656]: ---------------------------- MPD announces state update: player Jul 08 14:02:03 dubliners volumio[3656]: info: ControllerMpd::getState Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand status Jul 08 14:02:03 dubliners volumio[3656]: info: ------------------------------ 44ms Jul 08 14:02:03 dubliners volumio[3656]: info: sendMpdCommand status took 38 milliseconds Jul 08 14:02:03 dubliners volumio[3656]: info: ------------------------------ 37ms Jul 08 14:02:03 dubliners volumio[3656]: info: sendMpdCommand status took 30 milliseconds Jul 08 14:02:03 dubliners volumio[3656]: info: ------------------------------ 29ms Jul 08 14:02:03 dubliners volumio[3656]: info: sendMpdCommand status took 14 milliseconds Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::parseState Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::parseState Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::parseState Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 08 14:02:03 dubliners volumio[3656]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 08 14:02:03 dubliners volumio[3656]: info: sendMpdCommand playlistinfo took 11 milliseconds Jul 08 14:02:03 dubliners volumio[3656]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::parseTrackInfo Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::parseTrackInfo Jul 08 14:02:03 dubliners volumio[3656]: verbose: ControllerMpd::parseTrackInfo Jul 08 14:02:03 dubliners volumio[3656]: info: ControllerMpd::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::servicePushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2062,"duration":207,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mirrorball","artist":"Everything But the Girl","album":"Walking Wounded (Deluxe Edition)","uri":"INTERNAL/1 Daytime mix/Mirrorball Everything But the Girl.mp3","trackType":"mp3"} Jul 08 14:02:03 dubliners volumio[3656]: verbose: CURRENT POSITION 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::syncState stateService play Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::syncState currentStatus play Jul 08 14:02:03 dubliners volumio[3656]: info: Received an update from plugin. extracting info from payload Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:03 dubliners volumio[3656]: info: ControllerMpd::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::servicePushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2062,"duration":207,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mirrorball","artist":"Everything But the Girl","album":"Walking Wounded (Deluxe Edition)","uri":"INTERNAL/1 Daytime mix/Mirrorball Everything But the Girl.mp3","trackType":"mp3"} Jul 08 14:02:03 dubliners volumio[3656]: verbose: CURRENT POSITION 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::syncState stateService play Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::syncState currentStatus play Jul 08 14:02:03 dubliners volumio[3656]: info: Received an update from plugin. extracting info from payload Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:03 dubliners volumio[3656]: info: ControllerMpd::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::servicePushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2062,"duration":207,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":true,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mirrorball","artist":"Everything But the Girl","album":"Walking Wounded (Deluxe Edition)","uri":"INTERNAL/1 Daytime mix/Mirrorball Everything But the Girl.mp3","trackType":"mp3"} Jul 08 14:02:03 dubliners volumio[3656]: verbose: CURRENT POSITION 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::syncState stateService play Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::syncState currentStatus play Jul 08 14:02:03 dubliners volumio[3656]: info: Received an update from plugin. extracting info from payload Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:03 dubliners volumio[3656]: info: ------------------------------ 221ms Jul 08 14:02:03 dubliners volumio[3656]: info: ------------------------------ 213ms Jul 08 14:02:03 dubliners volumio[3656]: info: ------------------------------ 205ms Jul 08 14:02:03 dubliners volumio[3656]: info: CoreStateMachine::pushState Jul 08 14:02:03 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:03 dubliners volumio[3656]: info: CoreCommandRouter::volumioPushState Jul 08 14:02:05 dubliners volumio[3656]: info: CoreCommandRouter::volumioGetState Jul 08 14:02:05 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:06 dubliners volumio[3656]: info: CoreCommandRouter::volumioGetQueue Jul 08 14:02:06 dubliners volumio[3656]: info: CoreStateMachine::getQueue Jul 08 14:02:06 dubliners volumio[3656]: info: CorePlayQueue::getQueue Jul 08 14:02:06 dubliners volumio[3656]: info: CoreCommandRouter::volumioGetQueue Jul 08 14:02:06 dubliners volumio[3656]: info: CoreStateMachine::getQueue Jul 08 14:02:06 dubliners volumio[3656]: info: CorePlayQueue::getQueue Jul 08 14:02:07 dubliners volumio[3656]: info: CoreCommandRouter::volumioGetState Jul 08 14:02:07 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:07 dubliners volumio[3656]: info: CoreCommandRouter::volumioGetState Jul 08 14:02:07 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:07 dubliners volumio[3656]: info: CoreCommandRouter::volumioGetState Jul 08 14:02:07 dubliners volumio[3656]: info: CorePlayQueue::getTrack 2 Jul 08 14:02:12 dubliners cron[580]: 2025-07-08 14:02:12 1uZ59Q-0001En-Sh Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=118 Jul 08 14:02:12 dubliners cron[580]: 2025-07-08 14:02:12 1uZ59Q-0001En-Sh <= root@volumio U=root P=local S=2602 Jul 08 14:02:12 dubliners cron[580]: 2025-07-08 14:02:12 1uZ59Q-0001En-Sh Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=118 Jul 08 14:02:12 dubliners cron[580]: exim: could not open panic log - aborting: see message(s) above Jul 08 14:02:12 dubliners exim[4761]: 2025-07-08 14:02:12 1uZ59Q-0001En-Sh <= root@volumio U=root P=local S=2602 Jul 08 14:02:12 dubliners exim[4761]: 2025-07-08 14:02:12 1uZ59Q-0001En-Sh Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=114 egid=118 Jul 08 14:02:12 dubliners exim[4761]: exim: could not open panic log - aborting: see message(s) above Jul 08 14:02:12 dubliners CRON[4484]: (root) MAIL (mailed 2050 bytes of output but got status 0x0001 from MTA ) Jul 08 14:02:12 dubliners CRON[4484]: pam_unix(cron:session): session closed for user root Jul 08 14:02:17 dubliners volumio[3656]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 14:02:17 dubliners volumio[3656]: Error [ERR_TLS_CERT_ALTNAME_INVALID]: Hostname/IP does not match certificate's altnames: Host: lastfm.freetls.fastly.net. is not in the cert's altnames: DNS:retail.soundyoucanfeel.me Jul 08 14:02:17 dubliners volumio[3656]: at new NodeError (internal/errors.js:322:7) Jul 08 14:02:17 dubliners volumio[3656]: at Object.checkServerIdentity (tls.js:347:12) Jul 08 14:02:17 dubliners volumio[3656]: at TLSSocket.onConnectSecure (_tls_wrap.js:1525:27) Jul 08 14:02:17 dubliners volumio[3656]: at TLSSocket.emit (events.js:400:28) Jul 08 14:02:17 dubliners volumio[3656]: at TLSSocket._finishInit (_tls_wrap.js:937:8) Jul 08 14:02:17 dubliners volumio[3656]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:709:12) { Jul 08 14:02:17 dubliners volumio[3656]: reason: "Host: lastfm.freetls.fastly.net. is not in the cert's altnames: DNS:retail.soundyoucanfeel.me", Jul 08 14:02:17 dubliners volumio[3656]: host: 'lastfm.freetls.fastly.net', Jul 08 14:02:17 dubliners volumio[3656]: cert: { Jul 08 14:02:17 dubliners volumio[3656]: subject: [Object: null prototype] { CN: 'retail.soundyoucanfeel.me' }, Jul 08 14:02:17 dubliners volumio[3656]: issuer: [Object: null prototype] { C: 'US', O: "Let's Encrypt", CN: 'E6' }, Jul 08 14:02:17 dubliners volumio[3656]: subjectaltname: 'DNS:retail.soundyoucanfeel.me', Jul 08 14:02:17 dubliners volumio[3656]: infoAccess: [Object: null prototype] { Jul 08 14:02:17 dubliners volumio[3656]: 'OCSP - URI': [Array], Jul 08 14:02:17 dubliners volumio[3656]: 'CA Issuers - URI': [Array] Jul 08 14:02:17 dubliners volumio[3656]: }, Jul 08 14:02:17 dubliners volumio[3656]: bits: 384, Jul 08 14:02:17 dubliners volumio[3656]: pubkey: , Jul 08 14:02:17 dubliners volumio[3656]: asn1Curve: 'secp384r1', Jul 08 14:02:17 dubliners volumio[3656]: nistCurve: 'P-384', Jul 08 14:02:17 dubliners volumio[3656]: valid_from: 'Apr 28 03:36:45 2025 GMT', Jul 08 14:02:17 dubliners volumio[3656]: valid_to: 'Jul 27 03:36:44 2025 GMT', Jul 08 14:02:17 dubliners volumio[3656]: fingerprint: '2C:20:BE:9A:92:8E:B4:98:EB:F5:6A:8C:E4:D8:8C:F4:2F:F5:12:2C', Jul 08 14:02:17 dubliners volumio[3656]: fingerprint256: '3B:B8:8D:75:E4:6D:1F:40:E8:92:34:C3:C6:B6:AC:BB:25:4B:C7:29:AD:F6:D0:D0:F4:F5:1E:1D:EE:11:9F:C0', Jul 08 14:02:17 dubliners volumio[3656]: ext_key_usage: [ '1.3.6.1.5.5.7.3.1', '1.3.6.1.5.5.7.3.2' ], Jul 08 14:02:17 dubliners volumio[3656]: serialNumber: '057C433BC5FCC264600F5E0C05A8F648F712', Jul 08 14:02:17 dubliners volumio[3656]: raw: , Jul 08 14:02:17 dubliners volumio[3656]: issuerCertificate: { Jul 08 14:02:17 dubliners volumio[3656]: subject: [Object: null prototype], Jul 08 14:02:17 dubliners volumio[3656]: issuer: [Object: null prototype], Jul 08 14:02:17 dubliners volumio[3656]: infoAccess: [Object: null prototype], Jul 08 14:02:17 dubliners volumio[3656]: bits: 384, Jul 08 14:02:17 dubliners volumio[3656]: pubkey: , Jul 08 14:02:17 dubliners volumio[3656]: asn1Curve: 'secp384r1', Jul 08 14:02:17 dubliners volumio[3656]: nistCurve: 'P-384', Jul 08 14:02:17 dubliners volumio[3656]: valid_from: 'Mar 13 00:00:00 2024 GMT', Jul 08 14:02:17 dubliners volumio[3656]: valid_to: 'Mar 12 23:59:59 2027 GMT', Jul 08 14:02:17 dubliners volumio[3656]: fingerprint: 'C9:4D:C4:83:1A:90:1A:9F:EC:0F:B4:9B:71:BD:49:B5:AA:D4:FA:D0', Jul 08 14:02:17 dubliners volumio[3656]: fingerprint256: '76:E9:E2:88:AA:FC:0E:37:F4:39:0C:BF:94:6A:AD:99:7D:5C:1C:90:1B:3C:E5:13:D3:D8:FA:DB:AB:E2:AB:85', Jul 08 14:02:17 dubliners volumio[3656]: ext_key_usage: [Array], Jul 08 14:02:17 dubliners volumio[3656]: serialNumber: 'B0573E9173972770DBB487CB3A452B38', Jul 08 14:02:17 dubliners volumio[3656]: raw: , Jul 08 14:02:17 dubliners volumio[3656]: issuerCertificate: [Object] Jul 08 14:02:17 dubliners volumio[3656]: } Jul 08 14:02:17 dubliners volumio[3656]: }, Jul 08 14:02:17 dubliners volumio[3656]: code: 'ERR_TLS_CERT_ALTNAME_INVALID' Jul 08 14:02:17 dubliners volumio[3656]: } Jul 08 14:02:17 dubliners volumio[3656]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 14:02:18 dubliners sudo[4772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-08 14:01 Jul 08 14:02:18 dubliners sudo[4772]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="eb7109a0318f43be1cdb19572cb80f7f163a915d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Чт 01 фев 2024 20:49:33 MSK" VOLUMIO_VERSION="3.0" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="22506d91c2deba7d4d5e58d82babad9f"