Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.497+07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.272859978s timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.551+07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.639+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://database.volumio.cloud duration=87.120722ms error="Head \"https://database.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-07-02T14:14:43Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.645+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://functions.volumio.cloud duration=93.574185ms error="Head \"https://functions.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-07-02T14:14:43Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.654+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://functions.volumio.cloud duration=102.427611ms error="Head \"https://functions.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-07-02T14:14:43Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.695+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://google.com duration=143.925093ms error="Head \"https://google.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-08-10T08:37:42Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.702+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=149.694574ms error="Head \"https://browsing-performer.dfs.volumio.org\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-07-24T11:26:04Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.708+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://www.googleapis.com duration=156.596352ms error="Head \"https://www.googleapis.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-08-10T08:39:11Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.711+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=160.332055ms error="Head \"https://radio-directory.firebaseapp.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-07-20T15:01:16Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.719+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://securetoken.googleapis.com duration=167.412851ms error="Head \"https://securetoken.googleapis.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-08-10T08:39:11Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.760+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=http://pushupdates.volumio.org duration=208.099722ms Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.785+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=233.533704ms error="Head \"https://oauth-performer.dfs.volumio.org\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-07-08T11:28:45Z" Mar 25 00:35:14 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:14.921+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=https://myvolumio.firebaseio.com duration=368.929981ms error="Head \"https://myvolumio.firebaseio.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:35:14+07:00 is before 2026-07-06T15:01:47Z" Mar 25 00:35:15 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:15.205+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=http://plugins.volumio.org duration=652.869296ms Mar 25 00:35:15 volumio volumio5-onboarding[1739]: time=2026-03-25T00:35:15.279+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.274774033s timeout=10s endpoint=http://cddb.volumio.org duration=728.074999ms Mar 25 00:35:15 volumio sudo[3168]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 00:35:15 volumio sudo[3168]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:35:15 volumio sudo[3168]: pam_unix(sudo:session): session closed for user root Mar 25 00:35:15 volumio sudo[3170]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 00:35:15 volumio sudo[3170]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:35:15 volumio sudo[3170]: pam_unix(sudo:session): session closed for user root Mar 25 00:35:16 volumio volumio[1208]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.102 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: 5 Mar 25 00:35:16 volumio sudo[3174]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 00:35:16 volumio sudo[3174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:35:16 volumio sudo[3174]: pam_unix(sudo:session): session closed for user root Mar 25 00:35:16 volumio sudo[3176]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 00:35:16 volumio sudo[3176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:35:16 volumio sudo[3176]: pam_unix(sudo:session): session closed for user root Mar 25 00:35:16 volumio volumio[1208]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.102 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: 6 Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:35:17 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 00:35:17 volumio volumio[1208]: info: Received Get System Info Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:35:17 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:35:17 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:35:17 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:17 volumio volumio[1208]: info: Listing playlists Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 25 00:35:17 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 00:35:18 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 00:35:18 volumio volumio[1208]: info: Received Get System Info Mar 25 00:35:18 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:35:18 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:35:18 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:35:18 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:35:18 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:18 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:35:19 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 25 00:35:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 00:35:21 volumio volumio[1208]: info: Received Get System Info Mar 25 00:35:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:35:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:35:21 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:35:21 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:35:21 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:35:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 25 00:35:23 volumio volumio[1208]: info: CoreCommandRouter::volumioPlay Mar 25 00:35:23 volumio volumio[1208]: info: CoreStateMachine::play index undefined Mar 25 00:35:23 volumio volumio[1208]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 00:35:23 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:25 volumio volumio[1208]: info: CoreCommandRouter::volumioPlay Mar 25 00:35:25 volumio volumio[1208]: info: CoreStateMachine::play index undefined Mar 25 00:35:25 volumio volumio[1208]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 00:35:25 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:27 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::volumioGetBrowseSources Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::volumioGetBrowseSources Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::volumioGetBrowseSources Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:35:33 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 25 00:35:36 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 00:35:36 volumio volumio[1208]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 25 00:35:36 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 25 00:35:36 volumio volumio[1208]: info: Received Get System Version Mar 25 00:35:36 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 25 00:35:36 volumio volumio[1208]: info: Received Get System Info Mar 25 00:35:36 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:35:36 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:35:36 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:35:36 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:35:36 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:35:36 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:35:37 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:35:40 volumio systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories... Mar 25 00:35:41 volumio systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully. Mar 25 00:35:41 volumio systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories. Mar 25 00:35:41 volumio systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully. Mar 25 00:35:41 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:35:45 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:35:49 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:35:53 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:35:57 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:36:01 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:36:05 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 25 00:36:12 volumio ntpd[978]: PROTO: 47.243.51.23 unlink local addr 192.168.1.108 -> Mar 25 00:36:12 volumio ntpd[978]: PROTO: 191.223.208.112 unlink local addr 192.168.1.108 -> Mar 25 00:36:16 volumio ntpd[978]: PROTO: 223.255.185.2 unlink local addr 192.168.1.108 -> Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.034+07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.273642554s timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.060+07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.144+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://database.volumio.cloud duration=81.945463ms error="Head \"https://database.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-07-02T14:14:43Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.147+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://functions.volumio.cloud duration=84.864499ms error="Head \"https://functions.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-07-02T14:14:43Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.190+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://functions.volumio.cloud duration=128.787407ms error="Head \"https://functions.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-07-02T14:14:43Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.194+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://www.googleapis.com duration=132.544111ms error="Head \"https://www.googleapis.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-08-10T08:39:11Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.201+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=140.090648ms error="Head \"https://browsing-performer.dfs.volumio.org\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-07-24T11:26:04Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.201+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://securetoken.googleapis.com duration=140.825445ms error="Head \"https://securetoken.googleapis.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-08-10T08:39:11Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.205+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=144.138814ms error="Head \"https://radio-directory.firebaseapp.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-07-20T15:01:16Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.206+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://google.com duration=145.387592ms error="Head \"https://google.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-08-10T08:37:42Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.256+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=195.530093ms error="Head \"https://oauth-performer.dfs.volumio.org\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-07-08T11:28:45Z" Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.270+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=http://pushupdates.volumio.org duration=209.430796ms Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.412+07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=https://myvolumio.firebaseio.com duration=351.278204ms error="Head \"https://myvolumio.firebaseio.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-03-25T00:36:21+07:00 is before 2026-07-06T15:01:47Z" Mar 25 00:36:21 volumio sudo[3289]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 00:36:21 volumio sudo[3289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:36:21 volumio sudo[3291]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 00:36:21 volumio sudo[3289]: pam_unix(sudo:session): session closed for user root Mar 25 00:36:21 volumio sudo[3291]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:36:21 volumio sudo[3291]: pam_unix(sudo:session): session closed for user root Mar 25 00:36:21 volumio volumio[1208]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.102 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: 7 Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.757+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=http://cddb.volumio.org duration=695.290851ms Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 00:36:21 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:21.763+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" latency=-3724h10m52.275304517s timeout=10s endpoint=http://plugins.volumio.org duration=701.844389ms Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:21 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 00:36:21 volumio volumio[1208]: info: Received Get System Info Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:36:21 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:21 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:21 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:21 volumio volumio[1208]: info: Listing playlists Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 25 00:36:21 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 00:36:22 volumio sudo[3295]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 00:36:22 volumio sudo[3295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:36:22 volumio sudo[3297]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 00:36:22 volumio sudo[3297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:36:22 volumio sudo[3295]: pam_unix(sudo:session): session closed for user root Mar 25 00:36:22 volumio sudo[3297]: pam_unix(sudo:session): session closed for user root Mar 25 00:36:22 volumio volumio[1208]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.102 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: 8 Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:22 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 00:36:22 volumio volumio[1208]: info: Received Get System Info Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:36:22 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:22 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:22 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:22 volumio volumio[1208]: info: Listing playlists Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 25 00:36:22 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 00:36:23 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 25 00:36:23 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 00:36:23 volumio volumio[1208]: info: Received Get System Info Mar 25 00:36:23 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:36:23 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:36:23 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:36:23 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:23 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:23 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:36:26 volumio volumio[1208]: info: CoreCommandRouter::volumioGetQueue Mar 25 00:36:26 volumio volumio[1208]: info: CoreStateMachine::getQueue Mar 25 00:36:26 volumio volumio[1208]: info: CorePlayQueue::getQueue Mar 25 00:36:26 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 25 00:36:26 volumio volumio[1208]: info: Received Get System Info Mar 25 00:36:26 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:36:26 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:36:26 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:36:26 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:26 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:26 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:36:26 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 25 00:36:32 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 25 00:36:39 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 00:36:39 volumio volumio[1208]: info: CURURI: music-library Mar 25 00:36:39 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 00:36:40 volumio volumio[1208]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 25 00:36:40 volumio volumio[1208]: info: Received Get System Version Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 25 00:36:40 volumio volumio[1208]: info: Received Get System Info Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:36:40 volumio volumio[1208]: info: Discovery: Getting this device information Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::volumioGetState Mar 25 00:36:40 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:36:40 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 00:36:40 volumio volumio[1208]: info: CURURI: music-library/USB Mar 25 00:36:40 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:42 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 00:36:42 volumio volumio[1208]: info: CURURI: music-library/USB/KINGSTON Mar 25 00:36:42 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:42 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/The Pacifier-Ve si bat dac di.mp4 Mar 25 00:36:42 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/The Pacifier-Ve si bat dac di.mp4 in service mpd Mar 25 00:36:42 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=//extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FThe%20Pacifier-Ve%20si%20bat%20dac%20di.mp4&metadata=false Mar 25 00:36:42 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/The Pacifier-Ve si bat dac di.mp4 Mar 25 00:36:42 volumio volumio[1208]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Mar 25 00:36:42 volumio volumio[1208]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Mar 25 00:36:42 volumio volumio[1208]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Mar 25 00:36:42 volumio volumio[1208]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Mar 25 00:36:42 volumio volumio[1208]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Mar 25 00:36:42 volumio volumio[1208]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Mar 25 00:36:42 volumio volumio[1208]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Mar 25 00:36:42 volumio volumio[1208]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 25 00:36:42 volumio volumio[1208]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Mar 25 00:36:46 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 00:36:46 volumio volumio[1208]: info: CURURI: music-library/USB/KINGSTON/Lossness Mar 25 00:36:46 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:50 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 00:36:50 volumio volumio[1208]: info: CURURI: music-library/USB/KINGSTON/Lossness/90s Love Songs Mar 25 00:36:50 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/11 Iris_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/34 Hallelujah - Live at Sin-é, New York, NY - July_August 1993_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Endless Love_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Last Kiss_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/14 Endless Love (with Mariah Carey)_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/13 Don't Speak_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Preloading song: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 (Everything I Do) I Do It For You_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=Madonna/Celebration%20(double%20disc%20version)/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F27%20Frozen_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/11 Iris_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=The%20Goo%20Goo%20Dolls/Dizzy%20up%20the%20Girl/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F11%20Iris_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/11 Iris_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/34 Hallelujah - Live at Sin-é, New York, NY - July_August 1993_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=Jeff%20Buckley/Live%20At%20Sin-%C3%A9%20(Legacy%20Edition)/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F34%20Hallelujah%20-%20Live%20at%20Sin-%C3%A9%2C%20New%20York%2C%20NY%20-%20July_August%201993_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/34 Hallelujah - Live at Sin-é, New York, NY - July_August 1993_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Endless Love_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=Lionel%20Richie%2CDiana%20Ross/Love%20Songs/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F12%20Endless%20Love_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/12 Endless Love_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Last Kiss_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=Pearl%20Jam/rearviewmirror%20(greatest%20hits%201991-2003)/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F12%20Last%20Kiss_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/12 Last Kiss_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/14 Endless Love (with Mariah Carey)_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=Luther%20Vandross%2CMariah%20Carey/The%20Essential%20Luther%20Vandross/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F14%20Endless%20Love%20(with%20Mariah%20Carey)_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/14 Endless Love (with Mariah Carey)_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/13 Don't Speak_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=No%20Doubt/The%20Singles%20Collection/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F13%20Don't%20Speak_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/13 Don't Speak_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:50 volumio volumio[1208]: info: Exploding uri music-library/USB/KINGSTON/Lossness/90s Love Songs/12 (Everything I Do) I Do It For You_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav in service mpd Mar 25 00:36:50 volumio volumio[1208]: info: ALBUMART /albumart?cacheid=679&web=Bryan%20Adams/Waking%20Up%20The%20Neighbours/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2FLossness%2F90s%20Love%20Songs%2F12%20(Everything%20I%20Do)%20I%20Do%20It%20For%20You_%5Bwww.KeyBanQuyen.VN%5D_%5Bwww.Key4VIP.VN%5D.wav&metadata=false Mar 25 00:36:50 volumio volumio[1208]: info: URI /mnt/USB/KINGSTON/Lossness/90s Love Songs/12 (Everything I Do) I Do It For You_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:51 volumio volumio[1208]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::ClearQueue Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::stop Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::clearPlayQueue Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::saveQueue Mar 25 00:36:51 volumio volumio[1208]: info: CoreCommandRouter::volumioPushQueue Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::addQueueItems Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::addQueueItems Mar 25 00:36:51 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: CoreCommandRouter::volumioPushQueue Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::saveQueue Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::updateTrackBlock Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::getTrackBlock Mar 25 00:36:51 volumio volumio[1208]: info: CoreCommandRouter::volumioPlay Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::play index 0 Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::addQueueItems Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::addQueueItems Mar 25 00:36:51 volumio volumio[1208]: info: Preload queue cleared Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/11 Iris_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/11 Iris_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/34 Hallelujah - Live at Sin-é, New York, NY - July_August 1993_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/34 Hallelujah - Live at Sin-é, New York, NY - July_August 1993_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Endless Love_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Endless Love_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Last Kiss_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 Last Kiss_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/14 Endless Love (with Mariah Carey)_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/14 Endless Love (with Mariah Carey)_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/13 Don't Speak_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/13 Don't Speak_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Adding Item to queue: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 (Everything I Do) I Do It For You_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: Using cached record of: music-library/USB/KINGSTON/Lossness/90s Love Songs/12 (Everything I Do) I Do It For You_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::stop Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 00:36:51 volumio volumio[1208]: info: CoreCommandRouter::volumioPushQueue Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::saveQueue Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::play index undefined Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::updateTrackBlock Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::getTrackBlock Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:51 volumio volumio[1208]: info: CoreStateMachine::startPlaybackTimer Mar 25 00:36:51 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:51 volumio volumio[1208]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav Mar 25 00:36:51 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 00:36:51 volumio volumio[1208]: info: sendMpdCommand stop took 3 milliseconds Mar 25 00:36:51 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand clear Mar 25 00:36:51 volumio volumio[1208]: info: Mar 25 00:36:51 volumio volumio[1208]: ---------------------------- MPD announces system playlist update Mar 25 00:36:51 volumio volumio[1208]: info: Ignoring MPD Status Update Mar 25 00:36:51 volumio volumio[1208]: info: sendMpdCommand clear took 2 milliseconds Mar 25 00:36:51 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" Mar 25 00:36:51 volumio volumio[1208]: info: Mar 25 00:36:51 volumio volumio[1208]: ---------------------------- MPD announces system playlist update Mar 25 00:36:51 volumio volumio[1208]: info: Ignoring MPD Status Update Mar 25 00:36:51 volumio volumio[1208]: info: Mar 25 00:36:51 volumio volumio[1208]: ---------------------------- MPD announces system playlist update Mar 25 00:36:51 volumio volumio[1208]: info: Ignoring MPD Status Update Mar 25 00:36:51 volumio volumio[1208]: error: updateQueue error: null Mar 25 00:36:51 volumio volumio[1208]: info: Mar 25 00:36:51 volumio volumio[1208]: ---------------------------- MPD announces system playlist update Mar 25 00:36:51 volumio volumio[1208]: info: Ignoring MPD Status Update Mar 25 00:36:51 volumio volumio[1208]: info: ------------------------------ 8ms Mar 25 00:36:51 volumio volumio[1208]: info: sendMpdCommand add "USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" took 6 milliseconds Mar 25 00:36:51 volumio volumio[1208]: info: ------------------------------ 5ms Mar 25 00:36:51 volumio volumio[1208]: info: ------------------------------ 6ms Mar 25 00:36:51 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand play Mar 25 00:36:51 volumio volumio[1208]: info: Mar 25 00:36:51 volumio volumio[1208]: ---------------------------- MPD announces system playlist update Mar 25 00:36:51 volumio volumio[1208]: info: Ignoring MPD Status Update Mar 25 00:36:51 volumio volumio[1208]: info: Mar 25 00:36:51 volumio volumio[1208]: ---------------------------- MPD announces system playlist update Mar 25 00:36:51 volumio volumio[1208]: info: Ignoring MPD Status Update Mar 25 00:36:51 volumio volumio[1208]: info: ------------------------------ 10ms Mar 25 00:36:51 volumio volumio[1208]: info: sendMpdCommand play took 7 milliseconds Mar 25 00:36:51 volumio volumio[1208]: info: ------------------------------ 7ms Mar 25 00:36:51 volumio volumio[1208]: info: ------------------------------ 5ms Mar 25 00:36:51 volumio volumio[1208]: info: Mar 25 00:36:51 volumio volumio[1208]: ---------------------------- MPD announces state update: player Mar 25 00:36:51 volumio volumio[1208]: info: ControllerMpd::getState Mar 25 00:36:51 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand status Mar 25 00:36:52 volumio volumio[1208]: info: Mar 25 00:36:52 volumio volumio[1208]: ---------------------------- MPD announces state update: player Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::getState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand status Mar 25 00:36:52 volumio volumio[1208]: info: Mar 25 00:36:52 volumio volumio[1208]: ---------------------------- MPD announces state update: player Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::getState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand status Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand status took 70 milliseconds Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 00:36:52 volumio volumio[1208]: info: Mar 25 00:36:52 volumio volumio[1208]: ---------------------------- MPD announces state update: player Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::getState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand status Mar 25 00:36:52 volumio volumio[1208]: info: Mar 25 00:36:52 volumio volumio[1208]: ---------------------------- MPD announces state update: player Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::getState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand status Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand status took 74 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand status took 73 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand status took 3 milliseconds Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseTrackInfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::servicePushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":329,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"Frozen","artist":"Madonna","album":"Celebration (double disc version)","uri":"USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav","trackType":"wav"} Mar 25 00:36:52 volumio volumio[1208]: verbose: CURRENT POSITION 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState stateService play Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState currentStatus stop Mar 25 00:36:52 volumio volumio[1208]: info: ------------------------------ 87ms Mar 25 00:36:52 volumio volumio[1208]: info: Mar 25 00:36:52 volumio volumio[1208]: ---------------------------- MPD announces state update: player Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::getState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand status Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand status took 12 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand status took 2 milliseconds Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseTrackInfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseTrackInfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseTrackInfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseState Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::servicePushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211,"duration":329,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"Frozen","artist":"Madonna","album":"Celebration (double disc version)","uri":"USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav","trackType":"wav"} Mar 25 00:36:52 volumio volumio[1208]: verbose: CURRENT POSITION 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState stateService play Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState currentStatus play Mar 25 00:36:52 volumio volumio[1208]: info: Received an update from plugin. extracting info from payload Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::servicePushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: verbose: STATE SERVICE {"status":"play","position":0,"seek":316,"duration":329,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"Frozen","artist":"Madonna","album":"Celebration (double disc version)","uri":"USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav","trackType":"wav"} Mar 25 00:36:52 volumio volumio[1208]: verbose: CURRENT POSITION 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState stateService play Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState currentStatus play Mar 25 00:36:52 volumio volumio[1208]: info: Received an update from plugin. extracting info from payload Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::servicePushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968,"duration":329,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"Frozen","artist":"Madonna","album":"Celebration (double disc version)","uri":"USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav","trackType":"wav"} Mar 25 00:36:52 volumio volumio[1208]: verbose: CURRENT POSITION 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState stateService play Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState currentStatus play Mar 25 00:36:52 volumio volumio[1208]: info: Received an update from plugin. extracting info from payload Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.114+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=211 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.115+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.115+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=211 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.116+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.117+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=316 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.117+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.120+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=316 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.120+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=968 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.121+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.122+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.121+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=968 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.122+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio[1208]: info: ------------------------------ 133ms Mar 25 00:36:52 volumio volumio[1208]: info: ------------------------------ 132ms Mar 25 00:36:52 volumio volumio[1208]: info: ------------------------------ 62ms Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand playlistinfo took 47 milliseconds Mar 25 00:36:52 volumio volumio[1208]: info: sendMpdCommand playlistinfo took 47 milliseconds Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseTrackInfo Mar 25 00:36:52 volumio volumio[1208]: verbose: ControllerMpd::parseTrackInfo Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::servicePushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968,"duration":329,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"Frozen","artist":"Madonna","album":"Celebration (double disc version)","uri":"USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav","trackType":"wav"} Mar 25 00:36:52 volumio volumio[1208]: verbose: CURRENT POSITION 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState stateService play Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState currentStatus play Mar 25 00:36:52 volumio volumio[1208]: info: Received an update from plugin. extracting info from payload Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: ControllerMpd::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::servicePushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968,"duration":329,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"Frozen","artist":"Madonna","album":"Celebration (double disc version)","uri":"USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav","trackType":"wav"} Mar 25 00:36:52 volumio volumio[1208]: verbose: CURRENT POSITION 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState stateService play Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::syncState currentStatus play Mar 25 00:36:52 volumio volumio[1208]: info: Received an update from plugin. extracting info from payload Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio[1208]: info: CoreStateMachine::pushState Mar 25 00:36:52 volumio volumio[1208]: info: CorePlayQueue::getTrack 0 Mar 25 00:36:52 volumio volumio[1208]: info: CoreCommandRouter::volumioPushState Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.151+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=968 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.151+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.152+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=968 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.153+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=968 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.153+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.153+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.154+07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" state=STATUS_PLAYING positionMs=968 volume=100 Mar 25 00:36:52 volumio volumio5-onboarding[1739]: time=2026-03-25T00:36:52.154+07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.102:54730,00:00:00:00:00:00%01 @ 0x23f40f0" id="mnt/USB/KINGSTON/Lossness/90s Love Songs/27 Frozen_[www.KeyBanQuyen.VN]_[www.Key4VIP.VN].wav" title="27 - Frozen" Mar 25 00:36:52 volumio volumio[1208]: info: ------------------------------ 85ms Mar 25 00:36:52 volumio volumio[1208]: info: ------------------------------ 75ms Mar 25 00:36:53 volumio volumio[1208]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 00:36:53 volumio volumio[1208]: Error: certificate is not yet valid Mar 25 00:36:53 volumio volumio[1208]: at TLSSocket.onConnectSecure (node:_tls_wrap:1627:34) Mar 25 00:36:53 volumio volumio[1208]: at TLSSocket.emit (node:events:514:28) Mar 25 00:36:53 volumio volumio[1208]: at TLSSocket._finishInit (node:_tls_wrap:1038:8) Mar 25 00:36:53 volumio volumio[1208]: at ssl.onhandshakedone (node:_tls_wrap:824:12) { Mar 25 00:36:53 volumio volumio[1208]: code: 'CERT_NOT_YET_VALID' Mar 25 00:36:53 volumio volumio[1208]: } Mar 25 00:36:53 volumio volumio[1208]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 00:36:54 volumio sudo[3366]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-25 00:35' Mar 25 00:36:54 volumio sudo[3366]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"