-- Logs begin at Thu 2019-02-14 19:11:58 KST, end at Mon 2025-12-22 18:42:14 KST. -- Dec 22 18:41:00 top-core-1 volumio[800]: info: Setting Geolocation for MyVolumio to as1 Dec 22 18:41:00 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:00 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:00 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:00 top-core-1 volumio[800]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 22 18:41:01 top-core-1 volumio[800]: info: Updating MyVolumio device info Dec 22 18:41:01 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.792639, 0] ../source3/libsmb/nmblib.c:917(send_udp) Dec 22 18:41:01 top-core-1 nmbd[742]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793017, 0] ../source3/libsmb/nmblib.c:917(send_udp) Dec 22 18:41:01 top-core-1 nmbd[742]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793105, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 22 18:41:01 top-core-1 nmbd[742]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793203, 0] ../source3/libsmb/nmblib.c:917(send_udp) Dec 22 18:41:01 top-core-1 nmbd[742]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793278, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 22 18:41:01 top-core-1 nmbd[742]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793361, 0] ../source3/libsmb/nmblib.c:917(send_udp) Dec 22 18:41:01 top-core-1 nmbd[742]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793425, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 22 18:41:01 top-core-1 nmbd[742]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793504, 0] ../source3/libsmb/nmblib.c:917(send_udp) Dec 22 18:41:01 top-core-1 nmbd[742]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793575, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 22 18:41:01 top-core-1 nmbd[742]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793657, 0] ../source3/libsmb/nmblib.c:917(send_udp) Dec 22 18:41:01 top-core-1 nmbd[742]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 22 18:41:01 top-core-1 nmbd[742]: [2025/12/22 18:41:01.793717, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 22 18:41:01 top-core-1 nmbd[742]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 22 18:41:01 top-core-1 volumio[800]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 22 18:41:04 top-core-1 volumio[800]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.832&uuid=2828023b725cbe08aa342e4f8b95fbdc" http://updates.volumio.org/downloader-v1/track-device Dec 22 18:41:04 top-core-1 volumio[800]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 22 18:41:04 top-core-1 volumio[800]: Dload Upload Total Spent Left Speed Dec 22 18:41:04 top-core-1 volumio[800]: [1.6K blob data] Dec 22 18:41:04 top-core-1 volumio[800]: retrying in 5 seconds, trial 2 Dec 22 18:41:04 top-core-1 volumio[800]: info: Volumio Calling Home Dec 22 18:41:04 top-core-1 volumiologrotate[574]: ls: cannot access '/var/log/samba/log.wb-TOP': No such file or directory Dec 22 18:41:04 top-core-1 volumiologrotate[574]: ls: cannot access 'CORE': No such file or directory Dec 22 18:41:04 top-core-1 volumiologrotate[574]: ls: cannot access '1': No such file or directory Dec 22 18:41:04 top-core-1 volumio[800]: info: Volumio called home Dec 22 18:41:04 top-core-1 volumio[800]: info: MYVOLUMIO: Adding device Dec 22 18:41:04 top-core-1 volumio[800]: info: MYVOLUMIO: Evaluating Server Dec 22 18:41:05 top-core-1 volumio[800]: info: Setting Geolocation for MyVolumio to as1 Dec 22 18:41:05 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:05 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:06 top-core-1 volumio[800]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 22 18:41:06 top-core-1 volumio[800]: info: Updating MyVolumio device info Dec 22 18:41:06 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 18:41:07 top-core-1 volumio[800]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 22 18:41:07 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 18:41:07 top-core-1 volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 22 18:41:07 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:07 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:11 top-core-1 volumio[1037]: ................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................++++ Dec 22 18:41:12 top-core-1 ntpd[748]: Soliciting pool server 221.151.118.78 Dec 22 18:41:12 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:12 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 18:41:12 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 22 18:41:12 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 22 18:41:12 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 22 18:41:12 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 18:41:12 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 18:41:13 top-core-1 ntpd[748]: Soliciting pool server 121.174.142.81 Dec 22 18:41:13 top-core-1 ntpd[748]: Soliciting pool server 193.123.243.2 Dec 22 18:41:14 top-core-1 ntpd[748]: Soliciting pool server 121.174.142.82 Dec 22 18:41:15 top-core-1 ntpd[748]: Soliciting pool server 194.0.5.123 Dec 22 18:41:15 top-core-1 ntpd[748]: Soliciting pool server 175.195.167.194 Dec 22 18:41:16 top-core-1 ntpd[748]: Soliciting pool server 175.210.18.47 Dec 22 18:41:16 top-core-1 ntpd[748]: Soliciting pool server 3.39.176.65 Dec 22 18:41:17 top-core-1 ntpd[748]: Soliciting pool server 240b:400d:3:3300:aeda:71da:9779:d8f1 Dec 22 18:41:18 top-core-1 volumio[1037]: ...............................................................................++++ Dec 22 18:41:18 top-core-1 volumio[1037]: e is 65537 (0x010001) Dec 22 18:41:18 top-core-1 volumio[1037]: writing RSA key Dec 22 18:41:20 top-core-1 ntpd[748]: receive: Unexpected origin timestamp 0xecf390c0.02bccd92 does not match aorg 0000000000.00000000 from server@121.174.142.81 xmt 0xecf390c0.74e34ed3 Dec 22 18:41:20 top-core-1 ntpd[748]: receive: Unexpected origin timestamp 0xecf390c0.02bdb820 does not match aorg 0000000000.00000000 from server@221.151.118.78 xmt 0xecf390c0.76c3a3d6 Dec 22 18:41:20 top-core-1 ntpd[748]: receive: Unexpected origin timestamp 0xecf390c0.02b9d5fc does not match aorg 0000000000.00000000 from server@194.0.5.123 xmt 0xecf390c0.77fca834 Dec 22 18:41:26 top-core-1 systemd[1]: systemd-timedated.service: Succeeded. Dec 22 18:41:30 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:31 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:31 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:31 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:31 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:31 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:31 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:31 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:31 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:33 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:33 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:33 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:33 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:33 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:33 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:33 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 22 18:41:33 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 18:41:33 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:34 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:34 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 22 18:41:34 top-core-1 sudo[1499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 22 18:41:34 top-core-1 sudo[1499]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:34 top-core-1 sudo[1504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:41:34 top-core-1 sudo[1504]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:34 top-core-1 sudo[1499]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:34 top-core-1 sudo[1504]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:34 top-core-1 sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:41:34 top-core-1 sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:34 top-core-1 sudo[1512]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:34 top-core-1 sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 22 18:41:34 top-core-1 sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:34 top-core-1 sudo[1518]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:34 top-core-1 sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 18:41:34 top-core-1 sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:34 top-core-1 sudo[1525]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:34 top-core-1 sudo[1527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:41:34 top-core-1 sudo[1527]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:34 top-core-1 sudo[1527]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:34 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:34 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:34 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:34 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:34 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:34 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:35 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 18:41:35 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 18:41:35 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 22 18:41:35 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 18:41:35 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 18:41:37 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:37 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:37 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:37 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:37 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:37 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:37 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 22 18:41:37 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 22 18:41:37 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 22 18:41:41 top-core-1 sudo[1545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 18:41:41 top-core-1 sudo[1545]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:41 top-core-1 sudo[1545]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:41 top-core-1 sudo[1547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:41:41 top-core-1 sudo[1547]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:41 top-core-1 sudo[1547]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:41 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 22 18:41:42 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 22 18:41:42 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 22 18:41:43 top-core-1 sudo[1552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 18:41:43 top-core-1 sudo[1552]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:43 top-core-1 sudo[1552]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:43 top-core-1 sudo[1554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 18:41:43 top-core-1 sudo[1554]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:41:43 top-core-1 sudo[1554]: pam_unix(sudo:session): session closed for user root Dec 22 18:41:44 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 22 18:41:44 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 22 18:41:44 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetVisibleSources Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:45 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 22 18:41:45 top-core-1 volumio[800]: info: Received Get System Info Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:45 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:45 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:45 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:45 top-core-1 volumio[800]: info: Listing playlists Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 18:41:45 top-core-1 volumio[800]: info: Received Get System Info Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:45 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:45 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:45 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 22 18:41:46 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 22 18:41:48 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 18:41:48 top-core-1 volumio[800]: info: Received Get System Info Dec 22 18:41:48 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:48 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:48 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:48 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:48 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:48 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:49 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 18:41:49 top-core-1 volumio[800]: info: Received Get System Info Dec 22 18:41:49 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:49 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:49 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:49 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:49 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:49 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:50 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 22 18:41:50 top-core-1 volumio[800]: info: Received Get System Info Dec 22 18:41:50 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:41:50 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:41:50 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:41:50 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:41:50 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:41:50 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:41:50 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetQueue Dec 22 18:41:50 top-core-1 volumio[800]: info: CoreStateMachine::getQueue Dec 22 18:41:50 top-core-1 volumio[800]: info: CorePlayQueue::getQueue Dec 22 18:41:54 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 22 18:41:54 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 18:41:54 top-core-1 volumio[800]: info: CURURI: music-library/USB/Appreciate/17. 가요 Dec 22 18:41:54 top-core-1 volumio[800]: info: Preload queue cleared Dec 22 18:41:54 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/조하문 - 내 아픔 아시는 당신께.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/13 - Brown Eyed Soul - 한번만 더.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/01 - J-Min( 제이민 ) - 후( 後 ).flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/11 - Winterplay - 세월이 가면.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/01 - 솔라( 마마무 ) - 외로운 사람들.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/01 - 계피 - 그 이유가 내겐 아픔이었네.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/조하문 - 내 아픔 아시는 당신께.flac in service mpd Dec 22 18:41:54 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=%EC%A1%B0%ED%95%98%EB%AC%B8//extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F%EC%A1%B0%ED%95%98%EB%AC%B8%20-%20%EB%82%B4%20%EC%95%84%ED%94%94%20%EC%95%84%EC%8B%9C%EB%8A%94%20%EB%8B%B9%EC%8B%A0%EA%BB%98.flac&metadata=false Dec 22 18:41:54 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/조하문 - 내 아픔 아시는 당신께.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/13 - Brown Eyed Soul - 한번만 더.flac in service mpd Dec 22 18:41:54 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=Brown%20Eyed%20Soul/Back%20to%20the%20Soul%20Flight/extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F13%20-%20Brown%20Eyed%20Soul%20-%20%ED%95%9C%EB%B2%88%EB%A7%8C%20%EB%8D%94.flac&metadata=false Dec 22 18:41:54 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/13 - Brown Eyed Soul - 한번만 더.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/01 - J-Min( 제이민 ) - 후( 後 ).flac in service mpd Dec 22 18:41:54 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=J-Min(%20%EC%A0%9C%EC%9D%B4%EB%AF%BC%20)/The%201st%20Digital%20Single%20'%ED%9B%84(%20%E5%BE%8C%20)'/extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F01%20-%20J-Min(%20%EC%A0%9C%EC%9D%B4%EB%AF%BC%20)%20-%20%ED%9B%84(%20%E5%BE%8C%20).flac&metadata=false Dec 22 18:41:54 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/01 - J-Min( 제이민 ) - 후( 後 ).flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/11 - Winterplay - 세월이 가면.flac in service mpd Dec 22 18:41:54 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=Winterplay/Touche%20Mon%20Amour/extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F11%20-%20Winterplay%20-%20%EC%84%B8%EC%9B%94%EC%9D%B4%20%EA%B0%80%EB%A9%B4.flac&metadata=false Dec 22 18:41:54 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/11 - Winterplay - 세월이 가면.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/01 - 솔라( 마마무 ) - 외로운 사람들.flac in service mpd Dec 22 18:41:54 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=%EC%86%94%EB%9D%BC(%20%EB%A7%88%EB%A7%88%EB%AC%B4%20)/%EC%86%94%EB%9D%BC%EA%B0%90%EC%84%B1%20Part.5/extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F01%20-%20%EC%86%94%EB%9D%BC(%20%EB%A7%88%EB%A7%88%EB%AC%B4%20)%20-%20%EC%99%B8%EB%A1%9C%EC%9A%B4%20%EC%82%AC%EB%9E%8C%EB%93%A4.flac&metadata=false Dec 22 18:41:54 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/01 - 솔라( 마마무 ) - 외로운 사람들.flac Dec 22 18:41:54 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/01 - 계피 - 그 이유가 내겐 아픔이었네.flac in service mpd Dec 22 18:41:54 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=%EA%B3%84%ED%94%BC/%ED%95%98%EB%82%98%EB%BF%90%EC%9D%B8%20%EB%82%B4%ED%8E%B8%20OST%20Part.18/extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F01%20-%20%EA%B3%84%ED%94%BC%20-%20%EA%B7%B8%20%EC%9D%B4%EC%9C%A0%EA%B0%80%20%EB%82%B4%EA%B2%90%20%EC%95%84%ED%94%94%EC%9D%B4%EC%97%88%EB%84%A4.flac&metadata=false Dec 22 18:41:54 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/01 - 계피 - 그 이유가 내겐 아픔이었네.flac Dec 22 18:41:59 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 22 18:41:59 top-core-1 volumio[800]: info: CURURI: music-library/USB/Appreciate/17. 가요/박화요비 Dec 22 18:41:59 top-core-1 volumio[800]: info: Preload queue cleared Dec 22 18:41:59 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac Dec 22 18:41:59 top-core-1 volumio[800]: info: Preloading song: music-library/USB/Appreciate/17. 가요/박화요비/02 - 늦은사랑.flac Dec 22 18:41:59 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac in service mpd Dec 22 18:41:59 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=%EB%B0%95%ED%99%94%EC%9A%94%EB%B9%84/%EB%82%98%20%EA%B0%99%EC%9D%80%20%EC%97%AC%EC%9E%90/extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F%EB%B0%95%ED%99%94%EC%9A%94%EB%B9%84%2F01%20-%20%EB%82%98%20%EA%B0%99%EC%9D%80%20%EC%97%AC%EC%9E%90.flac&metadata=false Dec 22 18:41:59 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac Dec 22 18:41:59 top-core-1 volumio[800]: info: Exploding uri music-library/USB/Appreciate/17. 가요/박화요비/02 - 늦은사랑.flac in service mpd Dec 22 18:41:59 top-core-1 volumio[800]: info: ALBUMART /albumart?cacheid=70&web=%EB%B0%95%ED%99%94%EC%9A%94%EB%B9%84/%EC%82%B0%EB%B6%80%EC%9D%B8%EA%B3%BC%20OST%20(Part%202)/extralarge&path=%2Fmnt%2FUSB%2FAppreciate%2F17.%20%EA%B0%80%EC%9A%94%2F%EB%B0%95%ED%99%94%EC%9A%94%EB%B9%84%2F02%20-%20%EB%8A%A6%EC%9D%80%EC%82%AC%EB%9E%91.flac&metadata=false Dec 22 18:41:59 top-core-1 volumio[800]: info: URI /mnt/USB/Appreciate/17. 가요/박화요비/02 - 늦은사랑.flac Dec 22 18:42:00 top-core-1 volumio[800]: info: Preload queue cleared Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::ClearQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::stop Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::clearPlayQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::saveQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::addQueueItems Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::addQueueItems Dec 22 18:42:00 top-core-1 volumio[800]: info: Preload queue cleared Dec 22 18:42:00 top-core-1 volumio[800]: info: Adding Item to queue: music-library/USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac Dec 22 18:42:00 top-core-1 volumio[800]: info: Using cached record of: music-library/USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::saveQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::updateTrackBlock Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrackBlock Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPlay Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::play index 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::addQueueItems Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::addQueueItems Dec 22 18:42:00 top-core-1 volumio[800]: info: Preload queue cleared Dec 22 18:42:00 top-core-1 volumio[800]: info: Adding Item to queue: music-library/USB/Appreciate/17. 가요/박화요비/02 - 늦은사랑.flac Dec 22 18:42:00 top-core-1 volumio[800]: info: Using cached record of: music-library/USB/Appreciate/17. 가요/박화요비/02 - 늦은사랑.flac Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::stop Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::saveQueue Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::play index undefined Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::updateTrackBlock Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrackBlock Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::startPlaybackTimer Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::clearAddPlayTracks USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand stop Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand stop took 3 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand clear Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand clear took 0 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand add "USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac" Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces system playlist update Dec 22 18:42:00 top-core-1 volumio[800]: info: Ignoring MPD Status Update Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces system playlist update Dec 22 18:42:00 top-core-1 volumio[800]: info: Ignoring MPD Status Update Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand add "USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac" took 2 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand play Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces system playlist update Dec 22 18:42:00 top-core-1 volumio[800]: info: Ignoring MPD Status Update Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces system playlist update Dec 22 18:42:00 top-core-1 volumio[800]: info: Ignoring MPD Status Update Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces state update: player Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 7ms Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 6ms Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand play took 5 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 5ms Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::getState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand status Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 5ms Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces system playlist update Dec 22 18:42:00 top-core-1 volumio[800]: info: Ignoring MPD Status Update Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces system playlist update Dec 22 18:42:00 top-core-1 volumio[800]: info: Ignoring MPD Status Update Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces state update: player Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::getState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand status Dec 22 18:42:00 top-core-1 volumio[800]: error: Upnp client error: Error: This socket has been ended by the other party Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces state update: player Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::getState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand status Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand status took 7 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 6ms Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 5ms Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand status took 4 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces state update: player Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::getState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand status Dec 22 18:42:00 top-core-1 volumio[800]: info: Dec 22 18:42:00 top-core-1 volumio[800]: ---------------------------- MPD announces state update: player Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::getState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand status Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand status took 30 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand playlistinfo took 27 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand status took 4 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand status took 3 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseTrackInfo Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseTrackInfo Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseState Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::servicePushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"나 같은 여자","artist":"박화요비","album":"나 같은 여자","uri":"USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac","trackType":"flac"} Dec 22 18:42:00 top-core-1 volumio[800]: verbose: CURRENT POSITION 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState stateService play Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState currentStatus stop Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::servicePushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"나 같은 여자","artist":"박화요비","album":"나 같은 여자","uri":"USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac","trackType":"flac"} Dec 22 18:42:00 top-core-1 volumio[800]: verbose: CURRENT POSITION 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState stateService play Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState currentStatus play Dec 22 18:42:00 top-core-1 volumio[800]: info: Received an update from plugin. extracting info from payload Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 52ms Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 54ms Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseTrackInfo Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseTrackInfo Dec 22 18:42:00 top-core-1 volumio[800]: verbose: ControllerMpd::parseTrackInfo Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::servicePushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"638 Kbps","isStreaming":false,"title":"나 같은 여자","artist":"박화요비","album":"나 같은 여자","uri":"USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac","trackType":"flac"} Dec 22 18:42:00 top-core-1 volumio[800]: verbose: CURRENT POSITION 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState stateService play Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState currentStatus play Dec 22 18:42:00 top-core-1 volumio[800]: info: Received an update from plugin. extracting info from payload Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::servicePushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"800 Kbps","isStreaming":false,"title":"나 같은 여자","artist":"박화요비","album":"나 같은 여자","uri":"USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac","trackType":"flac"} Dec 22 18:42:00 top-core-1 volumio[800]: verbose: CURRENT POSITION 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState stateService play Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState currentStatus play Dec 22 18:42:00 top-core-1 volumio[800]: info: Received an update from plugin. extracting info from payload Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: ControllerMpd::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::servicePushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"800 Kbps","isStreaming":false,"title":"나 같은 여자","artist":"박화요비","album":"나 같은 여자","uri":"USB/Appreciate/17. 가요/박화요비/01 - 나 같은 여자.flac","trackType":"flac"} Dec 22 18:42:00 top-core-1 volumio[800]: verbose: CURRENT POSITION 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState stateService play Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::syncState currentStatus play Dec 22 18:42:00 top-core-1 volumio[800]: info: Received an update from plugin. extracting info from payload Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreStateMachine::pushState Dec 22 18:42:00 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:00 top-core-1 volumio[800]: info: CoreCommandRouter::volumioPushState Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 89ms Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 83ms Dec 22 18:42:00 top-core-1 volumio[800]: info: ------------------------------ 62ms Dec 22 18:42:02 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 18:42:02 top-core-1 volumio[800]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 22 18:42:02 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 22 18:42:02 top-core-1 volumio[800]: info: Received Get System Version Dec 22 18:42:02 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 18:42:02 top-core-1 volumio[800]: info: Received Get System Info Dec 22 18:42:02 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 22 18:42:02 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 22 18:42:02 top-core-1 volumio[800]: info: Discovery: Getting this device information Dec 22 18:42:02 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Dec 22 18:42:02 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Dec 22 18:42:02 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 22 18:42:04 top-core-1 volumiologrotate[574]: ls: cannot access '/var/log/samba/log.wb-TOP': No such file or directory Dec 22 18:42:04 top-core-1 volumiologrotate[574]: ls: cannot access 'CORE': No such file or directory Dec 22 18:42:04 top-core-1 volumiologrotate[574]: ls: cannot access '1': No such file or directory Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:09 top-core-1 volumio[800]: info: Retrieving Cloud Streaming UI Dec 22 18:42:09 top-core-1 volumio[800]: info: Getting Tidal Cloud Configuration Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:09 top-core-1 volumio[800]: info: Getting Qobuz Cloud Configuration Dec 22 18:42:09 top-core-1 volumio[800]: info: Asking plugin for UI Config Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:09 top-core-1 volumio[800]: info: Getting Spotify Cloud Configuration Dec 22 18:42:09 top-core-1 volumio[800]: info: Asking plugin for UI Config Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:09 top-core-1 volumio[800]: info: Saving Spotify Acccount Dec 22 18:42:09 top-core-1 volumio[800]: info: Got Tidal Cloud Configuration Dec 22 18:42:09 top-core-1 volumio[800]: info: Got it Dec 22 18:42:09 top-core-1 volumio[800]: info: Got it Dec 22 18:42:09 top-core-1 volumio[800]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 18:42:09 top-core-1 volumio[800]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 18:42:09 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Dec 22 18:42:10 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 22 18:42:10 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 22 18:42:12 top-core-1 volumio[800]: info: Disabling MyMusic plugin upnp Dec 22 18:42:13 top-core-1 sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Dec 22 18:42:13 top-core-1 sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 18:42:13 top-core-1 systemd[1]: Stopping UPnP Renderer front-end to MPD... Dec 22 18:42:14 top-core-1 volumio[800]: info: Enabling MyMusic plugin upnp Dec 22 18:42:14 top-core-1 volumio[800]: info: Enabling plugin upnp Dec 22 18:42:14 top-core-1 volumio[800]: info: Loading plugin "upnp"... Dec 22 18:42:14 top-core-1 volumio[800]: info: [1766396534327] Starting Upmpd Daemon Dec 22 18:42:14 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 22 18:42:14 top-core-1 volumio[800]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 18:42:14 top-core-1 volumio[800]: Error: listen EADDRINUSE: address already in use :::6599 Dec 22 18:42:14 top-core-1 volumio[800]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Dec 22 18:42:14 top-core-1 volumio[800]: at listenInCluster (net.js:1366:12) Dec 22 18:42:14 top-core-1 volumio[800]: at Server.listen (net.js:1452:7) Dec 22 18:42:14 top-core-1 volumio[800]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Dec 22 18:42:14 top-core-1 volumio[800]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Dec 22 18:42:14 top-core-1 volumio[800]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Dec 22 18:42:14 top-core-1 volumio[800]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 22 18:42:14 top-core-1 volumio[800]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Dec 22 18:42:14 top-core-1 volumio[800]: code: 'EADDRINUSE', Dec 22 18:42:14 top-core-1 volumio[800]: errno: -98, Dec 22 18:42:14 top-core-1 volumio[800]: syscall: 'listen', Dec 22 18:42:14 top-core-1 volumio[800]: address: '::', Dec 22 18:42:14 top-core-1 volumio[800]: port: 6599 Dec 22 18:42:14 top-core-1 volumio[800]: } Dec 22 18:42:14 top-core-1 volumio[800]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 18:42:14 top-core-1 sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-22 18:41 Dec 22 18:42:14 top-core-1 sudo[1670]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"