-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2024-04-01 01:02:17 UTC. -- Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c361baf2 does not match aorg 0000000000.00000000 from server@202.46.178.18 xmt 0xe9b485d6.60a13d6b Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c364425c does not match aorg 0000000000.00000000 from server@103.242.68.69 xmt 0xe9b485d6.60cca05e Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c35bcc79 does not match aorg 0000000000.00000000 from server@101.100.138.250 xmt 0xe9b485d6.606df99f Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c364425c does not match aorg 0000000000.00000000 from server@103.242.68.69 xmt 0xe9b485d6.6101527e Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c361baf2 does not match aorg 0000000000.00000000 from server@202.46.178.18 xmt 0xe9b485d6.60d65f95 Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c3633528 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xe9b485d6.610e70f2 Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c365550f does not match aorg 0000000000.00000000 from server@203.114.153.177 xmt 0xe9b485d6.60924433 Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c365550f does not match aorg 0000000000.00000000 from server@203.114.153.177 xmt 0xe9b485d6.60cfab3b Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c3604827 does not match aorg 0000000000.00000000 from server@114.110.37.123 xmt 0xe9b485d6.620b5fc2 Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c36680a2 does not match aorg 0000000000.00000000 from server@202.124.96.215 xmt 0xe9b485d6.612d5fed Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c36680a2 does not match aorg 0000000000.00000000 from server@202.124.96.215 xmt 0xe9b485d6.616e495c Apr 01 01:01:10 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485c0.c3604827 does not match aorg 0000000000.00000000 from server@114.110.37.123 xmt 0xe9b485d6.6241a256 Apr 01 01:01:10 volumio-one volumio[901]: info: MyVolumio status changed Apr 01 01:01:10 volumio-one volumio[901]: info: Streaming services startup Apr 01 01:01:10 volumio-one volumio[901]: info: Starting Streaming Daemon Apr 01 01:01:10 volumio-one volumio[901]: info: Removing browser output: myVolumio user plan is not superstar Apr 01 01:01:10 volumio-one volumio[901]: info: Removing audio output: Apr 01 01:01:10 volumio-one volumio[901]: info: Stoppping Tunnel 1 Apr 01 01:01:10 volumio-one sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 01 01:01:10 volumio-one sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 01:01:10 volumio-one sudo[1201]: pam_unix(sudo:session): session closed for user root Apr 01 01:01:10 volumio-one sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 01 01:01:10 volumio-one sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 01:01:11 volumio-one sudo[1204]: pam_unix(sudo:session): session closed for user root Apr 01 01:01:11 volumio-one volumio[901]: error: Cannot start Volumio Streaming Daemon Apr 01 01:01:11 volumio-one volumio[901]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 01 01:01:11 volumio-one volumio[901]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 01 01:01:11 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d7.600457a4 does not match aorg 0000000000.00000000 from server@103.242.68.68 xmt 0xe9b485d7.60b1fc99 Apr 01 01:01:11 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d7.5fffa88f does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe9b485d7.6177157e Apr 01 01:01:11 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d7.6005c193 does not match aorg 0000000000.00000000 from server@130.217.74.61 xmt 0xe9b485d7.615aadce Apr 01 01:01:11 volumio-one volumio[1057]: ......................................................++++ Apr 01 01:01:11 volumio-one volumio[901]: info: Setting Geolocation for MyVolumio to au1 Apr 01 01:01:11 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:11 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:11 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:11 volumio-one volumio[901]: info: Remote SSH Stopped Apr 01 01:01:12 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d8.6002029b does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9b485d8.60acc016 Apr 01 01:01:12 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d8.5ffd9a1e does not match aorg 0000000000.00000000 from server@130.217.74.63 xmt 0xe9b485d8.62783e66 Apr 01 01:01:13 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d9.60078c4d does not match aorg 0000000000.00000000 from server@103.242.68.68 xmt 0xe9b485d9.60ccc323 Apr 01 01:01:13 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d9.6005e732 does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe9b485d9.6190f0e8 Apr 01 01:01:13 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d9.6008ba67 does not match aorg 0000000000.00000000 from server@130.217.74.61 xmt 0xe9b485d9.616dd7b0 Apr 01 01:01:13 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485d9.5fffcf01 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xe9b485d9.649cf214 Apr 01 01:01:14 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485da.6006c137 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9b485da.60c7d6e2 Apr 01 01:01:14 volumio-one ntpd[633]: receive: flip 0 KoD origin timestamp 0xe9b485da.5fff6797 from 103.239.8.21 does not match 0000000000.00000000 - ignoring. Apr 01 01:01:14 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485da.600557ad does not match aorg 0000000000.00000000 from server@130.217.74.63 xmt 0xe9b485da.627d6b66 Apr 01 01:01:14 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485da.600809fb does not match aorg 0000000000.00000000 from server@202.46.185.18 xmt 0xe9b485da.62e6cbe8 Apr 01 01:01:15 volumio-one volumio[901]: info: Updating MyVolumio device info Apr 01 01:01:15 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:15 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:15 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:15 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485db.60084d83 does not match aorg 0000000000.00000000 from server@103.242.68.68 xmt 0xe9b485db.60d58d79 Apr 01 01:01:15 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485db.6004ded6 does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe9b485db.6191af6a Apr 01 01:01:15 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485db.60097729 does not match aorg 0000000000.00000000 from server@130.217.74.61 xmt 0xe9b485db.61bf2a47 Apr 01 01:01:15 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485db.60070d8c does not match aorg 0000000000.00000000 from server@123.255.62.42 xmt 0xe9b485db.637642c8 Apr 01 01:01:15 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485db.5ffea177 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xe9b485db.64acc90b Apr 01 01:01:16 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dc.6002567e does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9b485dc.60ae97c7 Apr 01 01:01:16 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dc.6000e77d does not match aorg 0000000000.00000000 from server@130.217.74.63 xmt 0xe9b485dc.62794dd4 Apr 01 01:01:16 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dc.600356c9 does not match aorg 0000000000.00000000 from server@202.46.185.18 xmt 0xe9b485dc.62dad248 Apr 01 01:01:17 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dd.6003773c does not match aorg 0000000000.00000000 from server@103.242.68.68 xmt 0xe9b485dd.60ea7369 Apr 01 01:01:17 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dd.6000f475 does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe9b485dd.61a2ed0c Apr 01 01:01:17 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dd.60047436 does not match aorg 0000000000.00000000 from server@130.217.74.61 xmt 0xe9b485dd.61ac8d38 Apr 01 01:01:17 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dd.600263dd does not match aorg 0000000000.00000000 from server@123.255.62.42 xmt 0xe9b485dd.638ca0ed Apr 01 01:01:17 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485dd.5ffccfb8 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xe9b485dd.64ee8b13 Apr 01 01:01:18 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485de.60041b15 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9b485de.60d1d933 Apr 01 01:01:18 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485de.6002a978 does not match aorg 0000000000.00000000 from server@130.217.74.63 xmt 0xe9b485de.629b6d91 Apr 01 01:01:18 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485de.6005134c does not match aorg 0000000000.00000000 from server@202.46.185.18 xmt 0xe9b485de.62f91242 Apr 01 01:01:19 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 01 01:01:19 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 01 01:01:19 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:19 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 01 01:01:19 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485df.6003d243 does not match aorg 0000000000.00000000 from server@103.242.68.68 xmt 0xe9b485df.60d93887 Apr 01 01:01:19 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485df.6004f262 does not match aorg 0000000000.00000000 from server@130.217.74.61 xmt 0xe9b485df.61b2b3a5 Apr 01 01:01:19 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485df.60016a66 does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe9b485df.61e28c80 Apr 01 01:01:19 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485df.6002b53a does not match aorg 0000000000.00000000 from server@123.255.62.42 xmt 0xe9b485df.6375b1eb Apr 01 01:01:19 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 01 01:01:19 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485df.5ffd35b8 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xe9b485df.64dbb5eb Apr 01 01:01:20 volumio-one volumio[1057]: .............................................................................................++++ Apr 01 01:01:20 volumio-one volumio[1057]: e is 65537 (0x010001) Apr 01 01:01:20 volumio-one volumio[1057]: writing RSA key Apr 01 01:01:20 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e0.60024c02 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9b485e0.6234d8d4 Apr 01 01:01:20 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e0.600106bf does not match aorg 0000000000.00000000 from server@130.217.74.63 xmt 0xe9b485e0.63f1d46d Apr 01 01:01:20 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e0.600370c7 does not match aorg 0000000000.00000000 from server@202.46.185.18 xmt 0xe9b485e0.645b4a50 Apr 01 01:01:21 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e1.60071127 does not match aorg 0000000000.00000000 from server@103.242.68.68 xmt 0xe9b485e1.611075b6 Apr 01 01:01:21 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e1.6004756e does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe9b485e1.618ee994 Apr 01 01:01:21 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e1.6005b0f3 does not match aorg 0000000000.00000000 from server@123.255.62.42 xmt 0xe9b485e1.636fd3fe Apr 01 01:01:21 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e1.5ffe7e55 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xe9b485e1.64929330 Apr 01 01:01:22 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e2.600457de does not match aorg 0000000000.00000000 from server@130.217.74.63 xmt 0xe9b485e2.6274613d Apr 01 01:01:22 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e2.6005c0d7 does not match aorg 0000000000.00000000 from server@202.46.185.18 xmt 0xe9b485e2.62d58315 Apr 01 01:01:23 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e3.60048f88 does not match aorg 0000000000.00000000 from server@123.255.62.42 xmt 0xe9b485e3.636968fe Apr 01 01:01:23 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e3.5ffe7280 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xe9b485e3.64b4620c Apr 01 01:01:24 volumio-one volumio-remote-updater[492]: No test mode Apr 01 01:01:24 volumio-one volumio-remote-updater[492]: No alpha test mode Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 01 01:01:24 volumio-one volumio[901]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 01 01:01:24 volumio-one volumio[901]: info: Completed starting MyVolumio Plugin Apr 01 01:01:24 volumio-one volumio[901]: info: BOOT COMPLETED Apr 01 01:01:24 volumio-one volumio[901]: [Metrics] CommandRouter: 71s 85.16ms Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::volumiosetStartupVolume Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 01:01:24 volumio-one volumio[901]: info: VolumeController:: Setting startup Volume 10 Apr 01 01:01:24 volumio-one volumio[901]: info: VolumeController::SetAlsaVolume10 Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::Close All Modals sent Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::Close All Modals sent Apr 01 01:01:24 volumio-one volumio[901]: info: CoreStateMachine::pushState Apr 01 01:01:24 volumio-one volumio[901]: info: CorePlayQueue::getTrack 0 Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 01:01:24 volumio-one volumio[901]: info: CoreCommandRouter::volumioPushState Apr 01 01:01:25 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b485e5.5ffe1c55 does not match aorg 0000000000.00000000 from server@123.255.62.42 xmt 0xe9b485e5.63380730 Apr 01 01:01:26 volumio-one volumio[901]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 01 01:01:26 volumio-one volumio[901]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 32 Apr 01 01:01:26 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 01 01:01:26 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 01 01:01:26 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 01 01:01:26 volumio-one volumio[901]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 01 01:01:26 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 01 01:01:27 volumio-one volumio[901]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 01 01:01:30 volumio-one volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 01 01:01:30 volumio-one volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 01 01:01:30 volumio-one volumio[901]: info: Retrieving Cloud Streaming UI Apr 01 01:01:30 volumio-one volumio[901]: info: CoreCommandRouter::volumioGetState Apr 01 01:01:30 volumio-one volumio[901]: info: CorePlayQueue::getTrack 0 Apr 01 01:01:30 volumio-one volumio[901]: info: MYVOLUMIO: Adding device Apr 01 01:01:30 volumio-one volumio[901]: info: MYVOLUMIO: Evaluating Server Apr 01 01:01:32 volumio-one volumio[901]: info: Getting Tidal Cloud Configuration Apr 01 01:01:32 volumio-one volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 01 01:01:32 volumio-one volumio[901]: info: Getting Qobuz Cloud Configuration Apr 01 01:01:32 volumio-one volumio[901]: info: Asking plugin for UI Config Apr 01 01:01:32 volumio-one volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 01 01:01:32 volumio-one volumio[901]: info: Getting Spotify Cloud Configuration Apr 01 01:01:32 volumio-one volumio[901]: info: Asking plugin for UI Config Apr 01 01:01:32 volumio-one volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 01 01:01:32 volumio-one volumio[901]: info: Saving Spotify Acccount Apr 01 01:01:32 volumio-one volumio[901]: info: Got Tidal Cloud Configuration Apr 01 01:01:32 volumio-one volumio[901]: info: Got it Apr 01 01:01:32 volumio-one volumio[901]: info: Got it Apr 01 01:01:32 volumio-one volumio[901]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 01 01:01:32 volumio-one volumio[901]: info: Setting Geolocation for MyVolumio to au1 Apr 01 01:01:32 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:32 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:32 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:33 volumio-one volumio[901]: info: Updating MyVolumio device info Apr 01 01:01:33 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 01:01:36 volumio-one volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 01 01:01:36 volumio-one volumio[901]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 01 01:01:37 volumio-one volumio[901]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources Apr 01 01:01:40 volumio-one volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources Apr 01 01:01:41 volumio-one volumio[901]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 01 01:01:43 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 01 01:01:43 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 01 01:01:48 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 01 01:01:51 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 01 01:01:53 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b48601.5ffde66e does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9b48601.60a549a6 Apr 01 01:01:53 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b48601.60042ec8 does not match aorg 0000000000.00000000 from server@130.217.74.61 xmt 0xe9b48601.62b01e3b Apr 01 01:01:53 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b48601.6002ba6f does not match aorg 0000000000.00000000 from server@202.46.185.18 xmt 0xe9b48601.62fb66e0 Apr 01 01:02:00 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 01 01:02:00 volumio-one volumio[901]: info: CURURI: music-library Apr 01 01:02:00 volumio-one volumio[901]: info: Preload queue cleared Apr 01 01:02:02 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 01 01:02:02 volumio-one volumio[901]: info: CURURI: music-library/NAS Apr 01 01:02:02 volumio-one volumio[901]: info: Preload queue cleared Apr 01 01:02:03 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 01 01:02:03 volumio-one volumio[901]: info: CURURI: music-library/NAS/Volumio-ONE Apr 01 01:02:03 volumio-one volumio[901]: info: Preload queue cleared Apr 01 01:02:13 volumio-one volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 01 01:02:13 volumio-one volumio[901]: info: CURURI: music-library/NAS/Volumio-ONE/Average White Band Apr 01 01:02:13 volumio-one volumio[901]: info: Preload queue cleared Apr 01 01:02:16 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b48618.5ffc241f does not match aorg 0000000000.00000000 from server@101.100.138.250 xmt 0xe9b48618.604bd1e8 Apr 01 01:02:16 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b48618.5fffc38f does not match aorg 0000000000.00000000 from server@114.110.37.123 xmt 0xe9b48618.622b725a Apr 01 01:02:17 volumio-one volumio[901]: info: Preload queue cleared Apr 01 01:02:17 volumio-one volumio[901]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 01 01:02:17 volumio-one volumio[901]: info: CoreStateMachine::ClearQueue Apr 01 01:02:17 volumio-one volumio[901]: info: CoreStateMachine::stop Apr 01 01:02:17 volumio-one volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 01 01:02:17 volumio-one volumio[901]: info: CorePlayQueue::clearPlayQueue Apr 01 01:02:17 volumio-one volumio[901]: info: CorePlayQueue::saveQueue Apr 01 01:02:17 volumio-one volumio[901]: info: CoreCommandRouter::volumioPushQueue Apr 01 01:02:17 volumio-one volumio[901]: info: CoreStateMachine::addQueueItems Apr 01 01:02:17 volumio-one volumio[901]: info: CorePlayQueue::addQueueItems Apr 01 01:02:17 volumio-one volumio[901]: info: Preload queue cleared Apr 01 01:02:17 volumio-one volumio[901]: info: Adding Item to queue: music-library/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake Apr 01 01:02:17 volumio-one volumio[901]: info: Exploding uri music-library/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake in service mpd Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F01%20-%20Cut%20The%20Cake.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/01 - Cut The Cake.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F02%20-%20School%20Boy%20Crush.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/02 - School Boy Crush.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F03%20-%20It%E2%80%99s%20A%20Mystery.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/03 - It’s A Mystery.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F04%20-%20Groovin%E2%80%99%20The%20Night%20Away.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/04 - Groovin’ The Night Away.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F05%20-%20If%20I%20Ever%20Lose%20This%20Heaven.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/05 - If I Ever Lose This Heaven.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F06%20-%20Why.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/06 - Why.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F07%20-%20High%20Flyin%E2%80%99%20Woman.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/07 - High Flyin’ Woman.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F08%20-%20Cloudy.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/08 - Cloudy.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F09%20-%20How%20Sweet%20Can%20You%20Get.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/09 - How Sweet Can You Get.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2F10%20-%20When%20They%20Bring%20Down%20The%20Curtain.flac&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/10 - When They Bring Down The Curtain.flac Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2FCut%20the%20Cake%20%5BDisc%205%5D%20-%20flac.cue&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/Cut the Cake [Disc 5] - flac.cue Apr 01 01:02:17 volumio-one volumio[901]: info: ALBUMART /albumart?cacheid=756&web=Average%20White%20Band/Cut%20the%20Cake%20%5BDisc%205%5D/extralarge&path=%2Fmnt%2FNAS%2FVolumio-ONE%2FAverage%20White%20Band%2F1975%20Cut%20the%20Cake%2FCut%20the%20Cake%20%5BDisc%205%5D%20-%20flac.cue&metadata=false Apr 01 01:02:17 volumio-one volumio[901]: info: URI /mnt/NAS/Volumio-ONE/Average White Band/1975 Cut the Cake/Cut the Cake [Disc 5] - flac.cue Apr 01 01:02:17 volumio-one volumio[901]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 01 01:02:17 volumio-one volumio[901]: Error: Unable to resolve or reject the same promise twice Apr 01 01:02:17 volumio-one volumio[901]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 01 01:02:17 volumio-one volumio[901]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 01 01:02:17 volumio-one volumio[901]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 01 01:02:17 volumio-one volumio[901]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 01 01:02:17 volumio-one volumio[901]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 01 01:02:17 volumio-one volumio[901]: at Socket.emit (events.js:315:20) Apr 01 01:02:17 volumio-one volumio[901]: at addChunk (internal/streams/readable.js:309:12) Apr 01 01:02:17 volumio-one volumio[901]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 01 01:02:17 volumio-one volumio[901]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 01 01:02:17 volumio-one volumio[901]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 01 01:02:17 volumio-one volumio[901]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 01 01:02:17 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b48619.6003f9d8 does not match aorg 0000000000.00000000 from server@103.242.68.69 xmt 0xe9b48619.60c6af29 Apr 01 01:02:17 volumio-one ntpd[633]: receive: Unexpected origin timestamp 0xe9b48619.5ffe3abb does not match aorg 0000000000.00000000 from server@123.255.61.170 xmt 0xe9b48619.617c4c12 Apr 01 01:02:17 volumio-one sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 01:01 Apr 01 01:02:17 volumio-one sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"