Jun 03 11:57:01 volumio ntpd[957]: CLOCK: time stepped by 10442.933646 Jun 03 11:57:01 volumio ntpd[957]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.872967, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 03 11:57:01 volumio nmbd[1123]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873288, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 03 11:57:01 volumio nmbd[1123]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873358, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 03 11:57:01 volumio nmbd[1123]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873417, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 03 11:57:01 volumio nmbd[1123]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873470, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 03 11:57:01 volumio nmbd[1123]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873523, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 03 11:57:01 volumio nmbd[1123]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873574, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 03 11:57:01 volumio nmbd[1123]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873627, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 03 11:57:01 volumio nmbd[1123]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873677, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 03 11:57:01 volumio nmbd[1123]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873730, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Jun 03 11:57:01 volumio nmbd[1123]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 03 11:57:01 volumio nmbd[1123]: [2026/06/03 11:57:01.873779, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 03 11:57:01 volumio nmbd[1123]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 03 11:57:03 volumio volumio[1329]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 03 11:57:03 volumio volumio[1329]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 03 11:57:03 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:03 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:03 volumio volumio[1329]: info: Starting MyVolumio Remote Streaming Endpoints Jun 03 11:57:03 volumio volumio[1329]: info: MyVolumio login type: Token Jun 03 11:57:03 volumio volumio[1329]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 03 11:57:03 volumio volumio[1329]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 03 11:57:06 volumio volumio[1329]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 03 11:57:06 volumio volumio[1329]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 03 11:57:06 volumio volumio[1329]: info: Streaming services startup Jun 03 11:57:06 volumio volumio[1329]: info: Starting Streaming Daemon Jun 03 11:57:06 volumio sudo[2101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 03 11:57:06 volumio volumio[1329]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 03 11:57:06 volumio sudo[2101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:06 volumio sudo[2101]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:06 volumio volumio[1329]: info: Discovery: A device disappeared from network Jun 03 11:57:06 volumio volumio[1329]: error: Cannot start Volumio Streaming Daemon Jun 03 11:57:06 volumio volumio[1329]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 03 11:57:06 volumio volumio[1329]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 03 11:57:06 volumio volumio[1329]: info: Discovery: A device disappeared from network Jun 03 11:57:07 volumio sudo[2111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 11:57:07 volumio sudo[2111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:07 volumio sudo[2113]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 11:57:07 volumio sudo[2113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:07 volumio sudo[2111]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:07 volumio sudo[2113]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:07 volumio volumio[1329]: info: Discovery: adding 48385517-dbf8-475b-bd56-7ffcde093cca Jun 03 11:57:07 volumio volumio[1329]: info: Discovery: Found device Volumio Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:07 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:07 volumio volumio[1329]: info: Discovery: this is already registered, 48385517-dbf8-475b-bd56-7ffcde093cca Jun 03 11:57:07 volumio volumio[1329]: info: Discovery: Found device Volumio Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:07 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:07 volumio volumio[1329]: error: MyVolumio Custom Token format not valid, refreshing it Jun 03 11:57:07 volumio volumio[1329]: verbose: New Socket.io Connection to 192.168.1.6 from 192.168.1.4 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetVisibleSources Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:07 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 03 11:57:07 volumio volumio[1329]: info: Received Get System Info Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 11:57:07 volumio volumio[1329]: info: Discovery: Getting this device information Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:07 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:07 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:07 volumio volumio[1329]: info: Listing playlists Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 11:57:07 volumio volumio[1329]: info: Received Get System Info Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 11:57:07 volumio volumio[1329]: info: Discovery: Getting this device information Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:07 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 11:57:07 volumio volumio[1329]: info: Received Get System Info Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 11:57:07 volumio volumio[1329]: info: Discovery: Getting this device information Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:07 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:07 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 11:57:08 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:08 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:08 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jun 03 11:57:08 volumio volumio[1329]: info: MyVolumio login type: Token Jun 03 11:57:08 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 11:57:08 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jun 03 11:57:08 volumio volumio[1329]: info: MyVolumio login type: Token Jun 03 11:57:08 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 11:57:09 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 03 11:57:09 volumio volumio[1329]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 03 11:57:10 volumio volumio[1329]: info: MyVolumio token set successfully Jun 03 11:57:10 volumio volumio[1329]: info: MYVOLUMIO: Adding device Jun 03 11:57:10 volumio volumio[1329]: info: MYVOLUMIO: Evaluating Server Jun 03 11:57:11 volumio volumio[1329]: info: MyVolumio status changed Jun 03 11:57:11 volumio volumio[1329]: info: Streaming services startup Jun 03 11:57:11 volumio volumio[1329]: info: Starting Streaming Daemon Jun 03 11:57:11 volumio volumio[1329]: info: Removing browser output: myVolumio user plan is not superstar Jun 03 11:57:11 volumio volumio[1329]: info: Removing audio output: Jun 03 11:57:11 volumio volumio[1329]: info: Stoppping Tunnel 1 Jun 03 11:57:11 volumio sudo[2151]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 03 11:57:11 volumio sudo[2151]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:11 volumio sudo[2154]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jun 03 11:57:11 volumio sudo[2154]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:11 volumio sudo[2151]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 11:57:11 volumio volumio[1329]: info: Received Get System Info Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 11:57:11 volumio volumio[1329]: info: Discovery: Getting this device information Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:11 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 11:57:11 volumio volumio[1329]: info: Received Get System Info Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 11:57:11 volumio volumio[1329]: info: Discovery: Getting this device information Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:11 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:11 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jun 03 11:57:11 volumio sudo[2154]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:11 volumio volumio[1329]: error: Cannot start Volumio Streaming Daemon Jun 03 11:57:11 volumio volumio[1329]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 03 11:57:11 volumio volumio[1329]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 03 11:57:11 volumio volumio[1329]: info: Remote SSH Stopped Jun 03 11:57:11 volumio volumio[1329]: info: MyVolumio login type: Token Jun 03 11:57:13 volumio volumio[1329]: info: Setting Geolocation for MyVolumio to as1 Jun 03 11:57:13 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:13 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:13 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:13 volumio volumio[1329]: info: Successfully Added MyVolumio device Jun 03 11:57:14 volumio volumio[1329]: info: Updating MyVolumio device info Jun 03 11:57:14 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:14 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:14 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:17 volumio volumio[1329]: info: Successfully Updated MyVolumio device Jun 03 11:57:17 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 03 11:57:18 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 03 11:57:18 volumio volumio[1329]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 03 11:57:18 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:18 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:19 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 03 11:57:20 volumio volumio[1329]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 03 11:57:20 volumio volumio[1329]: info: Received Get System Version Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 11:57:20 volumio volumio[1329]: info: Received Get System Info Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 11:57:20 volumio volumio[1329]: info: Discovery: Getting this device information Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:20 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:20 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 11:57:23 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:23 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:23 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 03 11:57:23 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 03 11:57:23 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 03 11:57:23 volumio volumio[1329]: info: CoreCommandRouter::volumioGetBrowseSources Jun 03 11:57:23 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 11:57:24 volumio volumio[1329]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jun 03 11:57:24 volumio volumio[1329]: info: Preparing to save Alsa Options, stopping services first Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:24 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::volumioPause Jun 03 11:57:24 volumio volumio[1329]: info: CoreStateMachine::pause Jun 03 11:57:24 volumio volumio[1329]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Cayin RU3 (U2)"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 11:57:24 volumio volumio[1329]: info: Setting mixer PCM for card Cayin RU3 (U2) Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 03 11:57:24 volumio volumio[1329]: info: Updating Volume Controller Parameters: Device: 5 Name: Cayin RU3 (U2) Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 03 11:57:24 volumio volumio[1329]: info: Disabling external Volume Control Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 11:57:24 volumio volumio[1329]: info: Preparing to generate the ALSA configuration file Jun 03 11:57:24 volumio volumio[1329]: info: VolumeController:: Volume=40 Mute =false Jun 03 11:57:24 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:57:24 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:24 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 03 11:57:25 volumio volumio[1329]: info: Asound.conf file written Jun 03 11:57:25 volumio sudo[2202]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 03 11:57:25 volumio sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:25 volumio sudo[2202]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:25 volumio volumio[1329]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jun 03 11:57:25 volumio volumio[1329]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jun 03 11:57:25 volumio volumio[1329]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jun 03 11:57:25 volumio volumio[1329]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Jun 03 11:57:25 volumio volumio[1329]: No state is present for card RU3U2 Jun 03 11:57:25 volumio volumio[1329]: Found hardware: "USB-Audio" "USB Mixer" "USB2d87:003b" "" "" Jun 03 11:57:25 volumio volumio[1329]: Hardware is initialized using a generic method Jun 03 11:57:25 volumio volumio[1329]: No state is present for card RU3U2 Jun 03 11:57:25 volumio volumio[1329]: info: Output device has changed, restarting MPD Jun 03 11:57:25 volumio volumio[1329]: info: Output device has changed, restarting Shairport Sync Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:25 volumio sudo[2208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 03 11:57:25 volumio sudo[2208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:25 volumio volumio[1329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 11:57:25 volumio volumio[1329]: info: Output device has changed, restarting MPD Jun 03 11:57:25 volumio sudo[2210]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 03 11:57:25 volumio sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:25 volumio sudo[2208]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:25 volumio volumio[1329]: info: Output device has changed, restarting Shairport Sync Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:25 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:25 volumio sudo[2220]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 03 11:57:25 volumio sudo[2220]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:25 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jun 03 11:57:25 volumio sudo[2218]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 03 11:57:25 volumio sudo[2218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:25 volumio sudo[2218]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:26 volumio volumio[1329]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 11:57:26 volumio volumio[1329]: info: MPD Permissions set Jun 03 11:57:26 volumio volumio[1329]: info: MPD Permissions set Jun 03 11:57:26 volumio systemd[1]: mpd.service: Deactivated successfully. Jun 03 11:57:26 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 03 11:57:26 volumio systemd[1]: mpd.service: Consumed 2.959s CPU time. Jun 03 11:57:26 volumio systemd[1]: mpd.socket: Deactivated successfully. Jun 03 11:57:26 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jun 03 11:57:26 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jun 03 11:57:26 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jun 03 11:57:26 volumio sudo[2230]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 03 11:57:26 volumio sudo[2230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 03 11:57:26 volumio sudo[2230]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 11:57:26 volumio volumio[1329]: info: Starting Shairport Sync Jun 03 11:57:26 volumio volumio[1329]: info: Starting Shairport Sync Jun 03 11:57:26 volumio sudo[2243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 11:57:26 volumio sudo[2243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:26 volumio sudo[2246]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 11:57:26 volumio sudo[2246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:57:26 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 03 11:57:26 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 03 11:57:26 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 03 11:57:26 volumio systemd[1]: shairport-sync.service: Consumed 1.514s CPU time. Jun 03 11:57:26 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 03 11:57:26 volumio sudo[2243]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:26 volumio volumio[1329]: info: Shairport-Sync Started Jun 03 11:57:26 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 03 11:57:26 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 03 11:57:26 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 03 11:57:26 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 03 11:57:27 volumio sudo[2246]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:27 volumio volumio[1329]: info: Shairport-Sync Started Jun 03 11:57:27 volumio mpd[2235]: 2026-06-03T11:57:27 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 03 11:57:27 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jun 03 11:57:27 volumio sudo[2220]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:27 volumio sudo[2210]: pam_unix(sudo:session): session closed for user root Jun 03 11:57:27 volumio volumio[1329]: error: MPD error: The expression evaluated to a falsy value: Jun 03 11:57:27 volumio volumio[1329]: assert.ok(self.idling) Jun 03 11:57:27 volumio volumio[1329]: error: The expression evaluated to a falsy value: Jun 03 11:57:27 volumio volumio[1329]: assert.ok(self.idling) Jun 03 11:57:27 volumio volumio[1329]: error: updateQueue error: null Jun 03 11:57:28 volumio volumio[1329]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 03 11:57:28 volumio volumio[1329]: info: CoreStateMachine::getcurrentVolume Jun 03 11:57:28 volumio volumio[1329]: info: CoreCommandRouter::volumioRetrievevolume Jun 03 11:57:28 volumio volumio[1329]: info: VolumeController:: Volume=40 Mute =false Jun 03 11:57:28 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:57:28 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:28 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:57:28 volumio volumio[1329]: info: CoreStateMachine::updateTrackBlock Jun 03 11:57:28 volumio volumio[1329]: info: CorePlayQueue::getTrackBlock Jun 03 11:57:28 volumio volumio[1329]: info: CoreCommandRouter::volumioRetrievevolume Jun 03 11:57:28 volumio volumio[1329]: info: VolumeController:: Volume=40 Mute =false Jun 03 11:57:28 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:57:28 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:28 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:57:35 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:35 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:37 volumio volumio[1329]: info: CoreCommandRouter::volumioGetQueue Jun 03 11:57:37 volumio volumio[1329]: info: CoreStateMachine::getQueue Jun 03 11:57:37 volumio volumio[1329]: info: CorePlayQueue::getQueue Jun 03 11:57:43 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 11:57:43 volumio volumio[1329]: info: CURURI: music-library Jun 03 11:57:43 volumio volumio[1329]: error: Failed LSINFO: null Jun 03 11:57:43 volumio volumio[1329]: info: Preload queue cleared Jun 03 11:57:50 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:57:50 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:57:54 volumio volumio[1329]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 03 11:57:55 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 03 11:58:00 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:58:00 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:02 volumio volumio[1329]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 11:58:02 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 03 11:58:02 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jun 03 11:58:03 volumio sudo[2357]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jun 03 11:58:03 volumio sudo[2357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:03 volumio sudo[2361]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 03 11:58:03 volumio sudo[2361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:03 volumio sudo[2361]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:03 volumio sudo[2373]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 03 11:58:03 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 03 11:58:03 volumio sudo[2369]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 03 11:58:03 volumio sudo[2369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:03 volumio sudo[2379]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 11:58:03 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 03 11:58:03 volumio sudo[2373]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:03 volumio sudo[2382]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 11:58:03 volumio sudo[2382]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:03 volumio sudo[2357]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:03 volumio sudo[2373]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:03 volumio sudo[2369]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:03 volumio sudo[2382]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:03 volumio sudo[2379]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:03 volumio sudo[2379]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:03 volumio sudo[2388]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 03 11:58:03 volumio sudo[2388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:05 volumio sudo[2388]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:06 volumio volumio[1329]: info: Received Get System Info Jun 03 11:58:06 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 11:58:06 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 11:58:06 volumio volumio[1329]: info: Discovery: Getting this device information Jun 03 11:58:06 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:58:06 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:06 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 11:58:06 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 03 11:58:06 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 03 11:58:07 volumio volumio5-onboarding[1588]: time=2026-06-03T11:58:07.263+09:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 03 11:58:09 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:58:09 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:12 volumio volumio[1329]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 03 11:58:12 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 03 11:58:12 volumio volumio[1329]: Disk list : [] Jun 03 11:58:12 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 03 11:58:12 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 03 11:58:12 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 03 11:58:13 volumio volumio[1329]: info: Received Get System Version Jun 03 11:58:13 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 11:58:18 volumio systemd[1]: Starting apt-daily-upgrade.service - Daily apt upgrade and clean activities... Jun 03 11:58:19 volumio systemd[1]: apt-daily-upgrade.service: Deactivated successfully. Jun 03 11:58:19 volumio systemd[1]: Finished apt-daily-upgrade.service - Daily apt upgrade and clean activities. Jun 03 11:58:20 volumio volumio[1329]: info: CoreCommandRouter::volumioGetState Jun 03 11:58:20 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:26 volumio kernel: usb 2-1: USB disconnect, device number 2 Jun 03 11:58:27 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Jun 03 11:58:27 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK Jun 03 11:58:27 volumio volumio[1329]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-id/wwn-0x5000039b52d00d75-part1 /dev/disk/by-partuuid/e8eba3b1-a148-48fc-9e4c-864b42da6246 /dev/disk/by-id/usb-I-O_DATA_HDPH-UT_000030000023840B-0:0-part1 /dev/disk/by-partlabel/Microsoft\\x20reserved\\x20partition /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/ata-TOSHIBA_MQ04ABD200_22GOP1J3T-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65936","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65936","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"TOSHIBA_MQ04ABD200","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABD200\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Microsoft\\x20reserved\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"34","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"262144","ID_PART_ENTRY_TYPE":"e3c9e316-0b5c-4db8-817d-f92df00215ae","ID_PART_ENTRY_UUID":"e8eba3b1-a148-48fc-9e4c-864b42da6246","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"764163d4-b35f-4da7-b892-9c51bf6e7b83","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"JT0A0U","ID_SERIAL":"TOSHIBA_MQ04ABD200_22GOP1J3T","ID_SERIAL_SHORT":"22GOP1J3T","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"HDPH-UT","ID_USB_MODEL_ENC":"HDPH-UT\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0168","ID_USB_REVISION":"0008","ID_USB_SERIAL":"I-O_DATA_HDPH-UT_000030000023840B-0:0","ID_USB_SERIAL_SHORT":"000030000023840B","ID_USB_TYPE":"disk","ID_USB_VENDOR":"I-O_DATA","ID_USB_VENDOR_ENC":"I-O\\x20DATA","ID_USB_VENDOR_ID":"04bb","ID_WWN":"0x5000039b52d00d75","ID_WWN_WITH_EXTENSION":"0x5000039b52d00d75","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"Microsoft reserved partition","SEQNUM":"2774","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"6198432"} Jun 03 11:58:27 volumio volumio[1329]: error: Cannot associate FS Label, not mounting Jun 03 11:58:27 volumio volumio[1329]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-id/wwn-0x5000039b52d00d75-part2 /dev/disk/by-uuid/A486493986490CEC /dev/disk/by-id/ata-TOSHIBA_MQ04ABD200_22GOP1J3T-part2 /dev/disk/by-label/HDPH-UT /dev/disk/by-id/usb-I-O_DATA_HDPH-UT_000030000023840B-0:0-part2 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-partuuid/45aeeef1-4396-4a3a-9d2c-b5e75696482d","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"26","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65936","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65936","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"HDPH-UT","ID_FS_LABEL_ENC":"HDPH-UT","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"A486493986490CEC","ID_FS_UUID_ENC":"A486493986490CEC","ID_MODEL":"TOSHIBA_MQ04ABD200","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABD200\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"264192","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"3906763872","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"45aeeef1-4396-4a3a-9d2c-b5e75696482d","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"764163d4-b35f-4da7-b892-9c51bf6e7b83","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"JT0A0U","ID_SERIAL":"TOSHIBA_MQ04ABD200_22GOP1J3T","ID_SERIAL_SHORT":"22GOP1J3T","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"HDPH-UT","ID_USB_MODEL_ENC":"HDPH-UT\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0168","ID_USB_REVISION":"0008","ID_USB_SERIAL":"I-O_DATA_HDPH-UT_000030000023840B-0:0","ID_USB_SERIAL_SHORT":"000030000023840B","ID_USB_TYPE":"disk","ID_USB_VENDOR":"I-O_DATA","ID_USB_VENDOR_ENC":"I-O\\x20DATA","ID_USB_VENDOR_ID":"04bb","ID_WWN":"0x5000039b52d00d75","ID_WWN_WITH_EXTENSION":"0x5000039b52d00d75","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"2775","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"6224604"} Jun 03 11:58:27 volumio sudo[2505]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Jun 03 11:58:27 volumio sudo[2505]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:27 volumio ntfs-3g[1498]: Unmounting /dev/sda2 (HDPH-UT) Jun 03 11:58:27 volumio ntfs-3g[1498]: Failed to sync device /dev/sda2: Input/output error Jun 03 11:58:27 volumio ntfs-3g[1498]: Failed to close volume /dev/sda2: Input/output error Jun 03 11:58:27 volumio systemd[1]: media-HDPH\x2dUT.mount: Deactivated successfully. Jun 03 11:58:27 volumio sudo[2505]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:30 volumio kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci_hcd Jun 03 11:58:30 volumio kernel: usb 2-1: New USB device found, idVendor=04bb, idProduct=0168, bcdDevice= 0.08 Jun 03 11:58:30 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jun 03 11:58:30 volumio kernel: usb 2-1: Product: I-O DATA HDPH-UT Jun 03 11:58:30 volumio kernel: usb 2-1: Manufacturer: I-O DATA DEVICE, INC. Jun 03 11:58:30 volumio kernel: usb 2-1: SerialNumber: 000030000023840B Jun 03 11:58:30 volumio kernel: usb-storage 2-1:1.0: USB Mass Storage device detected Jun 03 11:58:30 volumio kernel: scsi host0: usb-storage 2-1:1.0 Jun 03 11:58:31 volumio kernel: hwmon hwmon1: Undervoltage detected! Jun 03 11:58:31 volumio kernel: scsi 0:0:0:0: Direct-Access I-O DATA HDPH-UT 0008 PQ: 0 ANSI: 6 Jun 03 11:58:31 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jun 03 11:58:31 volumio kernel: sd 0:0:0:0: [sda] Spinning up disk... Jun 03 11:58:31 volumio volumio[1329]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/HDPH-UT Jun 03 11:58:33 volumio volumio[1329]: info: Scanning removed location : "USB/HDPH-UT" Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: info: Jun 03 11:58:33 volumio volumio[1329]: ---------------------------- MPD announces state update: update Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::getState Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: info: Jun 03 11:58:33 volumio volumio[1329]: ---------------------------- MPD announces state update: update Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: info: Jun 03 11:58:33 volumio volumio[1329]: ---------------------------- MPD announces state update: update Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::getState Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 99 milliseconds Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::getState Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 61 milliseconds Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: info: Command Router : Notfying DB Updatefalse Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::Close All Modals sent Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::servicePushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 11:58:33 volumio volumio[1329]: verbose: CURRENT POSITION 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState stateService stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState currentStatus stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: No code Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: ------------------------------ 398ms Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: info: Jun 03 11:58:33 volumio volumio[1329]: ---------------------------- MPD announces state update: update Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::getState Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 336 milliseconds Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 335 milliseconds Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 334 milliseconds Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 302 milliseconds Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 5 milliseconds Jun 03 11:58:33 volumio volumio[1329]: info: sendMpdCommand status took 3 milliseconds Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: info: Command Router : Notfying DB Updatefalse Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::Close All Modals sent Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: info: Command Router : Notfying DB Updatefalse Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::Close All Modals sent Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: info: Command Router : Notfying DB Updatefalse Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::Close All Modals sent Jun 03 11:58:33 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::servicePushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 11:58:33 volumio volumio[1329]: verbose: CURRENT POSITION 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState stateService stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState currentStatus stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: No code Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::servicePushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 11:58:33 volumio volumio[1329]: verbose: CURRENT POSITION 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState stateService stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState currentStatus stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: No code Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: ControllerMpd::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::servicePushState Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 11:58:33 volumio volumio[1329]: verbose: CURRENT POSITION 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState stateService stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::syncState currentStatus stop Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: No code Jun 03 11:58:33 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:33 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:33 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:33 volumio volumio[1329]: info: ------------------------------ 851ms Jun 03 11:58:33 volumio volumio[1329]: info: ------------------------------ 885ms Jun 03 11:58:33 volumio volumio[1329]: info: ------------------------------ 553ms Jun 03 11:58:34 volumio kernel: .ready Jun 03 11:58:34 volumio kernel: sd 0:0:0:0: [sda] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB) Jun 03 11:58:34 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Jun 03 11:58:34 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 Jun 03 11:58:34 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jun 03 11:58:35 volumio kernel: sda: sda1 sda2 Jun 03 11:58:35 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jun 03 11:58:35 volumio volumio[1329]: error: Cannot associate FS Label, not mounting Jun 03 11:58:35 volumio volumio[1329]: info: Mounting Device HDPH-UT Jun 03 11:58:36 volumio sudo[2551]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/HDPH-UT -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 11:58:36 volumio sudo[2551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 11:58:39 volumio ntfs-3g[2556]: Version 2022.10.3 integrated FUSE 28 Jun 03 11:58:39 volumio ntfs-3g[2556]: Mounted /dev/sda2 (Read-Write, label "HDPH-UT", NTFS 3.1) Jun 03 11:58:39 volumio ntfs-3g[2556]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 11:58:39 volumio ntfs-3g[2556]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Jun 03 11:58:39 volumio ntfs-3g[2556]: Global ownership and permissions enforced, configuration type 7 Jun 03 11:58:39 volumio sudo[2551]: pam_unix(sudo:session): session closed for user root Jun 03 11:58:39 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 11:58:39 volumio volumio[1329]: info: CURURI: music-library Jun 03 11:58:40 volumio volumio[1329]: info: Preload queue cleared Jun 03 11:58:40 volumio volumio[1329]: info: Scanning new location : "USB/HDPH-UT" Jun 03 11:58:40 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:40 volumio volumio[1329]: info: Jun 03 11:58:40 volumio volumio[1329]: ---------------------------- MPD announces state update: update Jun 03 11:58:40 volumio volumio[1329]: info: ControllerMpd::getState Jun 03 11:58:40 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:40 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:40 volumio volumio[1329]: info: Jun 03 11:58:40 volumio volumio[1329]: ---------------------------- MPD announces state update: update Jun 03 11:58:40 volumio volumio[1329]: info: ControllerMpd::getState Jun 03 11:58:40 volumio volumio[1329]: verbose: ControllerMpd::sendMpdCommand status Jun 03 11:58:40 volumio volumio[1329]: info: sendMpdCommand status took 6 milliseconds Jun 03 11:58:40 volumio volumio[1329]: info: sendMpdCommand status took 3 milliseconds Jun 03 11:58:40 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:40 volumio volumio[1329]: info: Command Router : Notfying DB Updatetrue Jun 03 11:58:40 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:40 volumio volumio[1329]: info: ControllerMpd::pushState Jun 03 11:58:40 volumio volumio[1329]: info: CoreCommandRouter::servicePushState Jun 03 11:58:40 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:40 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:40 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:40 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:40 volumio volumio[1329]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 11:58:40 volumio volumio[1329]: verbose: CURRENT POSITION 0 Jun 03 11:58:40 volumio volumio[1329]: info: CoreStateMachine::syncState stateService stop Jun 03 11:58:40 volumio volumio[1329]: info: CoreStateMachine::syncState currentStatus stop Jun 03 11:58:40 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:40 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:40 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 11:58:40 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:40 volumio volumio[1329]: info: No code Jun 03 11:58:40 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:40 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:40 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:40 volumio volumio[1329]: info: ------------------------------ 519ms Jun 03 11:58:40 volumio volumio[1329]: info: sendMpdCommand status took 598 milliseconds Jun 03 11:58:40 volumio volumio[1329]: info: sendMpdCommand status took 597 milliseconds Jun 03 11:58:40 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:41 volumio volumio[1329]: info: Command Router : Notfying DB Updatetrue Jun 03 11:58:41 volumio volumio[1329]: info: CoreCommandRouter::Close All Modals sent Jun 03 11:58:41 volumio volumio[1329]: verbose: ControllerMpd::parseState Jun 03 11:58:41 volumio volumio[1329]: info: ControllerMpd::pushState Jun 03 11:58:41 volumio volumio[1329]: info: CoreCommandRouter::servicePushState Jun 03 11:58:41 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:41 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:41 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:41 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:41 volumio volumio[1329]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 03 11:58:41 volumio volumio[1329]: verbose: CURRENT POSITION 0 Jun 03 11:58:41 volumio volumio[1329]: info: CoreStateMachine::syncState stateService stop Jun 03 11:58:41 volumio volumio[1329]: info: CoreStateMachine::syncState currentStatus stop Jun 03 11:58:41 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:41 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:41 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:41 volumio volumio[1329]: info: No code Jun 03 11:58:41 volumio volumio[1329]: info: CoreStateMachine::pushState Jun 03 11:58:41 volumio volumio[1329]: info: CorePlayQueue::getTrack 0 Jun 03 11:58:41 volumio volumio[1329]: info: CoreCommandRouter::volumioPushState Jun 03 11:58:41 volumio volumio[1329]: info: ------------------------------ 1120ms Jun 03 11:58:42 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 11:58:42 volumio volumio[1329]: info: CURURI: music-library/USB Jun 03 11:58:42 volumio volumio[1329]: info: Preload queue cleared Jun 03 11:58:43 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 11:58:43 volumio volumio[1329]: info: CURURI: music-library/USB/HDPH-UT Jun 03 11:58:43 volumio volumio[1329]: info: Preload queue cleared Jun 03 11:58:44 volumio volumio[1329]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 11:58:44 volumio volumio[1329]: info: CURURI: music-library/USB/HDPH-UT/MUSIC Jun 03 11:58:44 volumio volumio[1329]: info: Preload queue cleared Jun 03 11:58:48 volumio volumio[1329]: info: Preload queue cleared Jun 03 11:58:48 volumio volumio[1329]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 03 11:58:48 volumio volumio[1329]: info: CoreStateMachine::ClearQueue Jun 03 11:58:48 volumio volumio[1329]: info: CoreStateMachine::stop Jun 03 11:58:48 volumio volumio[1329]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 11:58:48 volumio volumio[1329]: info: CorePlayQueue::clearPlayQueue Jun 03 11:58:48 volumio volumio[1329]: info: CorePlayQueue::saveQueue Jun 03 11:58:48 volumio volumio[1329]: info: CoreCommandRouter::volumioPushQueue Jun 03 11:58:48 volumio volumio[1329]: info: CoreStateMachine::addQueueItems Jun 03 11:58:48 volumio volumio[1329]: info: CorePlayQueue::addQueueItems Jun 03 11:58:48 volumio volumio[1329]: info: Preload queue cleared Jun 03 11:58:48 volumio volumio[1329]: info: Adding Item to queue: music-library/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede Jun 03 11:58:48 volumio volumio[1329]: info: Exploding uri music-library/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede in service mpd Jun 03 11:58:48 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F01%20-%20April%20In%20Paris.flac&metadata=false Jun 03 11:58:48 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/01 - April In Paris.flac Jun 03 11:58:48 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F02%20-%20Rifftide.flac&metadata=false Jun 03 11:58:48 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/02 - Rifftide.flac Jun 03 11:58:48 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F03%20-%20Stardust.flac&metadata=false Jun 03 11:58:48 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/03 - Stardust.flac Jun 03 11:58:48 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F04%20-%20Stuffy.flac&metadata=false Jun 03 11:58:48 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/04 - Stuffy.flac Jun 03 11:58:48 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F05%20-%20Hollywood%20Stampede.flac&metadata=false Jun 03 11:58:48 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/05 - Hollywood Stampede.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F06%20-%20I'm%20Through%20With%20Love.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/06 - I'm Through With Love.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F07%20-%20What%20Is%20There%20To%20Say.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/07 - What Is There To Say.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F08%20-%20Wrap%20Up%20Your%20Troubles%20In%20Dreams.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/08 - Wrap Up Your Troubles In Dreams.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F09%20-%20Too%20Much%20Of%20A%20Good%20Thing.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/09 - Too Much Of A Good Thing.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F10%20-%20Bean%20Soup.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/10 - Bean Soup.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F11%20-%20Someone%20To%20Watch%20Over%20Me.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/11 - Someone To Watch Over Me.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F12%20-%20It's%20The%20Talk%20Of%20The%20Town.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/12 - It's The Talk Of The Town.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F13%20-%20Isn't%20It%20Romantic.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/13 - Isn't It Romantic.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F14%20-%20Bean-A-Re-Bop.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/14 - Bean-A-Re-Bop.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F15%20-%20The%20Way%20You%20Look%20Tonight.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/15 - The Way You Look Tonight.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2F16%20-%20Phantomesque.flac&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/16 - Phantomesque.flac Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2FHollywood%20Stampede.cue&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/Hollywood Stampede.cue Jun 03 11:58:49 volumio volumio[1329]: info: ALBUMART /albumart?cacheid=567&web=Coleman%20Hawkins/Hollywood%20Stampede/extralarge&path=%2Fmnt%2FUSB%2FHDPH-UT%2FMUSIC%2F1947%20-%20Hollywood%20Stampede%2FHollywood%20Stampede.cue&metadata=false Jun 03 11:58:49 volumio volumio[1329]: info: URI /mnt/USB/HDPH-UT/MUSIC/1947 - Hollywood Stampede/Hollywood Stampede.cue Jun 03 11:58:49 volumio volumio[1329]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 11:58:49 volumio volumio[1329]: Error: Unable to resolve or reject the same promise twice Jun 03 11:58:49 volumio volumio[1329]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 03 11:58:49 volumio volumio[1329]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Jun 03 11:58:49 volumio volumio[1329]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jun 03 11:58:49 volumio volumio[1329]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jun 03 11:58:49 volumio volumio[1329]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jun 03 11:58:49 volumio volumio[1329]: at Socket.emit (node:events:514:28) Jun 03 11:58:49 volumio volumio[1329]: at addChunk (node:internal/streams/readable:343:12) Jun 03 11:58:49 volumio volumio[1329]: at readableAddChunk (node:internal/streams/readable:312:11) Jun 03 11:58:49 volumio volumio[1329]: at Readable.push (node:internal/streams/readable:253:10) Jun 03 11:58:49 volumio volumio[1329]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jun 03 11:58:49 volumio volumio[1329]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 11:58:57 volumio sudo[2613]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-03 11:57' Jun 03 11:58:57 volumio sudo[2613]: 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"