-- Logs begin at Tue 2025-11-04 21:23:07 +07, end at Tue 2025-11-04 22:26:41 +07. -- Nov 04 22:25:04 volumio sshd[21579]: Accepted password for volumio from 192.168.1.143 port 63369 ssh2 Nov 04 22:25:04 volumio sshd[21579]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Nov 04 22:25:04 volumio systemd[1]: Created slice User Slice of UID 1000. Nov 04 22:25:04 volumio systemd[1]: Starting User Runtime Directory /run/user/1000... Nov 04 22:25:04 volumio systemd-logind[849]: New session 3 of user volumio. Nov 04 22:25:04 volumio systemd[1]: Started User Runtime Directory /run/user/1000. Nov 04 22:25:04 volumio systemd[1]: Starting User Manager for UID 1000... Nov 04 22:25:04 volumio systemd[21617]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Nov 04 22:25:04 volumio systemd[21617]: Listening on GnuPG cryptographic agent and passphrase cache. Nov 04 22:25:04 volumio systemd[21617]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Nov 04 22:25:04 volumio systemd[21617]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Nov 04 22:25:04 volumio systemd[21617]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Nov 04 22:25:04 volumio systemd[21617]: Listening on GnuPG network certificate management daemon. Nov 04 22:25:04 volumio systemd[21617]: Reached target Timers. Nov 04 22:25:04 volumio systemd[21617]: Reached target Paths. Nov 04 22:25:04 volumio systemd[21617]: Starting D-Bus User Message Bus Socket. Nov 04 22:25:04 volumio systemd[21617]: Listening on Sound System. Nov 04 22:25:04 volumio systemd[21617]: Listening on D-Bus User Message Bus Socket. Nov 04 22:25:04 volumio systemd[21617]: Reached target Sockets. Nov 04 22:25:04 volumio systemd[21617]: Reached target Basic System. Nov 04 22:25:04 volumio systemd[21617]: Reached target Default. Nov 04 22:25:04 volumio systemd[21617]: Startup finished in 62ms. Nov 04 22:25:04 volumio systemd[1]: Started User Manager for UID 1000. Nov 04 22:25:04 volumio systemd[1]: Started Session 3 of user volumio. Nov 04 22:25:26 volumio volumio[1280]: info: Nov 04 22:25:26 volumio volumio[1280]: ---------------------------- MPD announces system playlist update Nov 04 22:25:26 volumio volumio[1280]: info: Ignoring MPD Status Update Nov 04 22:25:26 volumio volumio[1280]: info: Nov 04 22:25:26 volumio volumio[1280]: ---------------------------- MPD announces state update: player Nov 04 22:25:26 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:25:26 volumio volumio[1280]: info: Nov 04 22:25:26 volumio volumio[1280]: ---------------------------- MPD announces system playlist update Nov 04 22:25:26 volumio volumio[1280]: info: Ignoring MPD Status Update Nov 04 22:25:26 volumio volumio[1280]: info: Nov 04 22:25:26 volumio volumio[1280]: ---------------------------- MPD announces state update: player Nov 04 22:25:26 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:25:26 volumio volumio[1280]: info: Nov 04 22:25:26 volumio volumio[1280]: ---------------------------- MPD announces system playlist update Nov 04 22:25:26 volumio volumio[1280]: info: Ignoring MPD Status Update Nov 04 22:25:26 volumio volumio[1280]: info: Nov 04 22:25:26 volumio volumio[1280]: ---------------------------- MPD announces state update: player Nov 04 22:25:26 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:25:26 volumio volumio[1280]: info: ------------------------------ 2ms Nov 04 22:25:26 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:25:26 volumio volumio[1280]: info: ------------------------------ 1ms Nov 04 22:25:26 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:25:26 volumio volumio[1280]: info: ------------------------------ 1ms Nov 04 22:25:26 volumio volumio[1280]: info: sendMpdCommand status took 0 milliseconds Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:25:26 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 04 22:25:26 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 04 22:25:26 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:25:26 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:25:26 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:25:26 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:25:26 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3698938,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:25:26 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:25:26 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:25:26 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:25:26 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:25:26 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3698938,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:25:26 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:25:26 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:25:26 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:25:26 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:25:26 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3698938,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:25:26 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:25:26 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:25:26 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:25:26 volumio volumio[1280]: info: ------------------------------ 9ms Nov 04 22:25:26 volumio volumio[1280]: info: ------------------------------ 9ms Nov 04 22:25:26 volumio volumio[1280]: info: ------------------------------ 10ms Nov 04 22:25:41 volumio volumio[1280]: verbose: New Socket.io Connection to 192.168.1.83:3000 from 192.168.1.57 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Nov 04 22:25:44 volumio sudo[21837]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/INTERNAL/MYHD -o noatime,dmask=0000,fmask=0000 Nov 04 22:25:44 volumio sudo[21837]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Nov 04 22:25:44 volumio sudo[21837]: pam_unix(sudo:session): session closed for user root Nov 04 22:25:58 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 22:25:58 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 22:25:58 volumio volumio[1280]: info: Discovery: Getting this device information Nov 04 22:25:58 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:25:58 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 22:25:59 volumio volumio[1280]: verbose: New Socket.io Connection to 192.168.1.83:3000 from 192.168.1.57 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Nov 04 22:25:59 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:25:59 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 04 22:25:59 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 04 22:25:59 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 22:25:59 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 22:25:59 volumio volumio[1280]: info: Discovery: Getting this device information Nov 04 22:25:59 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:25:59 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 22:26:00 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:01 volumio sudo[21907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 04 22:26:01 volumio sudo[21907]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 22:26:01 volumio sudo[21907]: pam_unix(sudo:session): session closed for user root Nov 04 22:26:01 volumio sudo[21910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 04 22:26:01 volumio sudo[21910]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 22:26:01 volumio sudo[21910]: pam_unix(sudo:session): session closed for user root Nov 04 22:26:01 volumio volumio[1280]: verbose: New Socket.io Connection to 192.168.1.83 from 192.168.1.57 UA: Mozilla/5.0 (Linux; Android 15; SM-S9080 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 04 22:26:01 volumio sudo[21913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 04 22:26:01 volumio sudo[21913]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 22:26:01 volumio sudo[21913]: pam_unix(sudo:session): session closed for user root Nov 04 22:26:01 volumio sudo[21916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 04 22:26:01 volumio sudo[21916]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 22:26:01 volumio sudo[21916]: pam_unix(sudo:session): session closed for user root Nov 04 22:26:01 volumio volumio[1280]: verbose: New Socket.io Connection to 192.168.1.83 from 192.168.1.57 UA: Mozilla/5.0 (Linux; Android 15; SM-S9080 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::volumioGetVisibleSources Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 04 22:26:01 volumio volumio[1280]: info: Received Get System Info Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 22:26:01 volumio volumio[1280]: info: Discovery: Getting this device information Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:01 volumio volumio[1280]: info: Listing playlists Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 04 22:26:01 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 04 22:26:02 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 04 22:26:03 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 04 22:26:03 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 04 22:26:03 volumio volumio[1280]: info: Received Get System Info Nov 04 22:26:03 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 22:26:03 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 22:26:03 volumio volumio[1280]: info: Discovery: Getting this device information Nov 04 22:26:03 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:03 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 22:26:03 volumio volumio[1280]: info: CoreCommandRouter::volumioGetQueue Nov 04 22:26:03 volumio volumio[1280]: info: CoreStateMachine::getQueue Nov 04 22:26:03 volumio volumio[1280]: info: CorePlayQueue::getQueue Nov 04 22:26:04 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 04 22:26:04 volumio volumio[1280]: info: Received Get System Info Nov 04 22:26:04 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 22:26:04 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 22:26:04 volumio volumio[1280]: info: Discovery: Getting this device information Nov 04 22:26:04 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:04 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 22:26:08 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:08 volumio volumio[1280]: info: CURURI: music-library Nov 04 22:26:08 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:10 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:10 volumio volumio[1280]: info: CURURI: music-library/NAS Nov 04 22:26:10 volumio volumio[1280]: error: Failed LSINFO: null Nov 04 22:26:10 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:11 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 04 22:26:11 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:11 volumio volumio[1280]: info: CURURI: music-library/INTERNAL Nov 04 22:26:11 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:14 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:14 volumio volumio[1280]: info: CURURI: music-library/USB Nov 04 22:26:14 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:16 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:16 volumio volumio[1280]: info: CURURI: music-library/USB/6C1E9D471E9D0B6A Nov 04 22:26:16 volumio volumio[1280]: error: Failed LSINFO: null Nov 04 22:26:16 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:17 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:17 volumio volumio[1280]: info: CURURI: music-library/USB/Зарезервировано_системой Nov 04 22:26:17 volumio volumio[1280]: error: Failed LSINFO: null Nov 04 22:26:17 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 04 22:26:20 volumio volumio[1280]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 04 22:26:20 volumio volumio[1280]: info: Received Get System Version Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 04 22:26:20 volumio volumio[1280]: info: Received Get System Info Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 22:26:20 volumio volumio[1280]: info: Discovery: Getting this device information Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 22:26:20 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:20 volumio volumio[1280]: info: CURURI: music-library/INTERNAL Nov 04 22:26:20 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:26 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:26 volumio volumio[1280]: info: CURURI: music-library/INTERNAL/peppy_screensaver Nov 04 22:26:26 volumio volumio[1280]: error: Failed LSINFO: null Nov 04 22:26:26 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:27 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 22:26:27 volumio volumio[1280]: info: CURURI: music-library/INTERNAL/PeppyMeterBasic Nov 04 22:26:27 volumio volumio[1280]: info: Preload queue cleared Nov 04 22:26:28 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 22:26:28 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 22:26:28 volumio volumio[1280]: info: Discovery: Getting this device information Nov 04 22:26:28 volumio volumio[1280]: info: CoreCommandRouter::volumioGetState Nov 04 22:26:28 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 22:26:36 volumio volumio[1280]: info: Retrieving Cloud Streaming UI Nov 04 22:26:36 volumio volumio[1280]: info: Getting Tidal Cloud Configuration Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 22:26:36 volumio volumio[1280]: info: Getting Qobuz Cloud Configuration Nov 04 22:26:36 volumio volumio[1280]: info: Asking plugin for UI Config Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 22:26:36 volumio volumio[1280]: info: Getting Spotify Cloud Configuration Nov 04 22:26:36 volumio volumio[1280]: info: Asking plugin for UI Config Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 22:26:36 volumio volumio[1280]: info: Saving Spotify Acccount Nov 04 22:26:36 volumio volumio[1280]: info: Got Tidal Cloud Configuration Nov 04 22:26:36 volumio volumio[1280]: info: Got it Nov 04 22:26:36 volumio volumio[1280]: info: Got it Nov 04 22:26:36 volumio volumio[1280]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 22:26:36 volumio volumio[1280]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 22:26:36 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand update Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand update took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatetrue Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatetrue Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770197,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 42ms Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 25 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 25 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatetrue Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770197,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 41ms Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 21 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 20 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 4 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 2 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatefalse Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatefalse Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatefalse Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770197,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 81ms Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 27 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770197,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770197,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770197,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 64ms Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 47ms Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 44ms Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand rescan Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand rescan took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 2 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 2 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatetrue Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatetrue Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatetrue Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 36 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 22 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770949,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770949,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 42ms Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 43ms Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: Nov 04 22:26:38 volumio volumio[1280]: ---------------------------- MPD announces state update: update Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::getState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand status Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 11 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 12 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 2 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 2 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand status took 1 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatefalse Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatefalse Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: info: Command Router : Notfying DB Updatefalse Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::Close All Modals sent Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseState Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770949,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 83ms Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 24 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 15 milliseconds Nov 04 22:26:38 volumio volumio[1280]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: verbose: ControllerMpd::parseTrackInfo Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770949,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770949,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ControllerMpd::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::servicePushState Nov 04 22:26:38 volumio volumio[1280]: info: CorePlayQueue::getTrack 0 Nov 04 22:26:38 volumio volumio[1280]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3770949,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"SIDEPIECE - Cry For You ","artist":"Radio Record","album":null,"uri":"https://air.unmixed.ru/record320","trackType":""} Nov 04 22:26:38 volumio volumio[1280]: verbose: CURRENT POSITION 0 Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState stateService play Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::syncState currentStatus play Nov 04 22:26:38 volumio volumio[1280]: info: Received an update from plugin. extracting info from payload Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreStateMachine::pushState Nov 04 22:26:38 volumio volumio[1280]: info: CoreCommandRouter::volumioPushState Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 60ms Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 51ms Nov 04 22:26:38 volumio volumio[1280]: info: ------------------------------ 50ms Nov 04 22:26:40 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 22:26:41 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 04 22:26:41 volumio volumio[1280]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 04 22:26:41 volumio volumio[1280]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 22:26:41 volumio volumio[1280]: Error: getaddrinfo -3007 Nov 04 22:26:41 volumio volumio[1280]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Nov 04 22:26:41 volumio volumio[1280]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Nov 04 22:26:41 volumio volumio[1280]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Nov 04 22:26:41 volumio volumio[1280]: code: -3007, Nov 04 22:26:41 volumio volumio[1280]: errno: -3007, Nov 04 22:26:41 volumio volumio[1280]: syscall: 'getaddrinfo' Nov 04 22:26:41 volumio volumio[1280]: } Nov 04 22:26:41 volumio volumio[1280]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 22:26:41 volumio sudo[22150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-04 22:25 Nov 04 22:26:41 volumio sudo[22150]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"