-- Logs begin at Wed 2026-03-25 00:56:55 UTC, end at Wed 2026-03-25 01:38:41 UTC. -- Mar 25 01:37:00 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:00 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:00 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:00 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:00 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:01 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:01 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:01 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:01 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:01 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ saveWirelessNetworkSettings: {"ssid":"Software","security":"wpa2","password":"12345678"} Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: Saving new wireless network Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiConfig: {"page":"system_controller/network"} Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 01:37:02 ifi-lsq-idsd-phantom1 sudo[19944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Mar 25 01:37:02 ifi-lsq-idsd-phantom1 sudo[19944]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:02 ifi-lsq-idsd-phantom1 sudo[19944]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: Restarting Advertising due to device name change Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:02 ifi-lsq-idsd-phantom1 sudo[19949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Mar 25 01:37:02 ifi-lsq-idsd-phantom1 sudo[19949]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:02 ifi-lsq-idsd-phantom1 systemd[1]: Starting Wireless Services... Mar 25 01:37:02 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:02 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:02 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:03 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:03 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: A device disappeared from network Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: error: Could not retrieve plugin audio_interface multiroom Mar 25 01:37:03 ifi-lsq-idsd-phantom1 wireless.js[19951]: Cleaning previous... Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20034]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20034]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20034]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20036]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20036]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20036]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:03 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:03 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:03 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:03 ifi-lsq-idsd-phantom1 wireless.js[19951]: Stopped aP Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20043]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20043]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20050]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20050]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20062]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20062]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 25 01:37:03 ifi-lsq-idsd-phantom1 sudo[20064]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:04 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:05 ifi-lsq-idsd-phantom1 kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:05 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:05 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:05 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:05 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:05 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:06 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:06 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:06 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:06 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:07 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:07 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:07 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:07 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:07 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: adding 45542791-9ba4-4a0e-89e9-c42087783d53 Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: Found device lsq iDSD PHANTOM1 Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:08 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:08 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:08 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:09 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:09 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20064]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:09 ifi-lsq-idsd-phantom1 wireless.js[19951]: Start wireless flow Mar 25 01:37:09 ifi-lsq-idsd-phantom1 wireless.js[19951]: Stopped hotspot (if there).. Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20286]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20286]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20286]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20288]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20288]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20288]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:09 ifi-lsq-idsd-phantom1 wireless.js[19951]: DHCP IP Mar 25 01:37:09 ifi-lsq-idsd-phantom1 wireless.js[19951]: Start ap Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20291]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20291]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:09 ifi-lsq-idsd-phantom1 dhcpcd[20292]: sending commands to master dhcpcd process Mar 25 01:37:09 ifi-lsq-idsd-phantom1 dhcpcd[894]: control command: /sbin/dhcpcd Mar 25 01:37:09 ifi-lsq-idsd-phantom1 sudo[20291]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:09 ifi-lsq-idsd-phantom1 wpa_supplicant[20290]: Successfully initialized wpa_supplicant Mar 25 01:37:09 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:09 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:09 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:10 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:10 ifi-lsq-idsd-phantom1 kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Mar 25 01:37:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:10 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:10 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:11 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:11 ifi-lsq-idsd-phantom1 sudo[20340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:11 ifi-lsq-idsd-phantom1 sudo[20340]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:11 ifi-lsq-idsd-phantom1 sudo[20340]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:11 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:11 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:11 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:11 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:11 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:11 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:11 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:11 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:11 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:11 ifi-lsq-idsd-phantom1 sudo[20391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:11 ifi-lsq-idsd-phantom1 sudo[20391]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:11 ifi-lsq-idsd-phantom1 sudo[20391]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:12 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:12 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:12 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:12 ifi-lsq-idsd-phantom1 sudo[20436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:12 ifi-lsq-idsd-phantom1 sudo[20436]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:12 ifi-lsq-idsd-phantom1 sudo[20436]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:12 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:12 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:12 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:13 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:13 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:13 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:13 ifi-lsq-idsd-phantom1 sudo[20488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:13 ifi-lsq-idsd-phantom1 sudo[20488]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:13 ifi-lsq-idsd-phantom1 sudo[20488]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:13 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:13 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:14 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:14 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:14 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:14 ifi-lsq-idsd-phantom1 sudo[20533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:14 ifi-lsq-idsd-phantom1 sudo[20533]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:14 ifi-lsq-idsd-phantom1 sudo[20533]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:15 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:15 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:15 ifi-lsq-idsd-phantom1 wpa_supplicant[20294]: wlan0: Trying to associate with f0:2f:74:b5:c3:1c (SSID='Software' freq=5745 MHz) Mar 25 01:37:15 ifi-lsq-idsd-phantom1 wpa_supplicant[20294]: wlan0: Associated with f0:2f:74:b5:c3:1c Mar 25 01:37:15 ifi-lsq-idsd-phantom1 wpa_supplicant[20294]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 25 01:37:15 ifi-lsq-idsd-phantom1 wpa_supplicant[20294]: wlan0: WPA: Key negotiation completed with f0:2f:74:b5:c3:1c [PTK=CCMP GTK=CCMP] Mar 25 01:37:15 ifi-lsq-idsd-phantom1 wpa_supplicant[20294]: wlan0: CTRL-EVENT-CONNECTED - Connection to f0:2f:74:b5:c3:1c completed [id=0 id_str=] Mar 25 01:37:15 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: carrier acquired Mar 25 01:37:15 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:15 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: IAID 00:43:26:86 Mar 25 01:37:15 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: adding address fe80::e796:f957:6ce8:e85f Mar 25 01:37:15 ifi-lsq-idsd-phantom1 dhcpcd[894]: ipv6_addaddr1: Permission denied Mar 25 01:37:15 ifi-lsq-idsd-phantom1 sudo[20575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:15 ifi-lsq-idsd-phantom1 sudo[20575]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:15 ifi-lsq-idsd-phantom1 sudo[20575]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:15 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:15 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:15 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:16 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:16 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:16 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: soliciting a DHCP lease Mar 25 01:37:16 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: offered 192.168.50.89 from 192.168.50.1 Mar 25 01:37:16 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: probing address 192.168.50.89/24 Mar 25 01:37:16 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: soliciting an IPv6 router Mar 25 01:37:16 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:16 ifi-lsq-idsd-phantom1 sudo[20620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:16 ifi-lsq-idsd-phantom1 sudo[20620]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:16 ifi-lsq-idsd-phantom1 sudo[20620]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:16 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:17 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:17 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:17 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:17 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:17 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:17 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:17 ifi-lsq-idsd-phantom1 sudo[20661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:17 ifi-lsq-idsd-phantom1 sudo[20661]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:17 ifi-lsq-idsd-phantom1 sudo[20661]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:18 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:18 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:18 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:18 ifi-lsq-idsd-phantom1 sudo[20696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:18 ifi-lsq-idsd-phantom1 sudo[20696]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:18 ifi-lsq-idsd-phantom1 sudo[20696]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:18 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:18 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:18 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:19 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:19 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:19 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:19 ifi-lsq-idsd-phantom1 sudo[20735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:19 ifi-lsq-idsd-phantom1 sudo[20735]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:19 ifi-lsq-idsd-phantom1 sudo[20735]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:19 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:20 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:20 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:20 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:20 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:20 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:20 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:20 ifi-lsq-idsd-phantom1 sudo[20781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:20 ifi-lsq-idsd-phantom1 sudo[20781]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:20 ifi-lsq-idsd-phantom1 sudo[20781]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:21 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:21 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:21 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: leased 192.168.50.89 for 86400 seconds Mar 25 01:37:21 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: adding route to 192.168.50.0/24 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 dhcpcd[894]: wlan0: adding default route via 192.168.50.1 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 wireless.js[19951]: trying... Mar 25 01:37:21 ifi-lsq-idsd-phantom1 sudo[20865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 25 01:37:21 ifi-lsq-idsd-phantom1 sudo[20865]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:21 ifi-lsq-idsd-phantom1 sudo[20865]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:21 ifi-lsq-idsd-phantom1 wireless.js[19951]: Connected to: ----Software Mar 25 01:37:21 ifi-lsq-idsd-phantom1 wireless.js[19951]: ---- Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Sent Meta Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: success Mar 25 01:37:21 ifi-lsq-idsd-phantom1 sudo[20869]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 sudo[20869]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[948]: ntpd exiting on signal 15 (Terminated) Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[948]: 212.227.240.160 local addr 192.168.1.222 -> Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: Stopping Network Time Service... Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[948]: 138.89.14.60 local addr 192.168.1.222 -> Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[948]: 172.104.209.204 local addr 192.168.1.222 -> Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[948]: 216.144.228.179 local addr 192.168.1.222 -> Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[948]: 23.142.248.8 local addr 192.168.1.222 -> Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[948]: 108.61.215.221 local addr 192.168.1.222 -> Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: ntp.service: Succeeded. Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: Stopped Network Time Service. Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: Starting Network Time Service... Mar 25 01:37:21 ifi-lsq-idsd-phantom1 sudo[20869]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:21 ifi-lsq-idsd-phantom1 wireless.js[19951]: ... joined AP, wlan0 IPv4 is 192.168.50.89, ipV6 is undefined Mar 25 01:37:21 ifi-lsq-idsd-phantom1 wireless.js[19951]: It's done! AP Mar 25 01:37:21 ifi-lsq-idsd-phantom1 node[476]: metadata.title changed Mar 25 01:37:21 ifi-lsq-idsd-phantom1 node[476]: in spotify Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20874]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20874]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: Started Network Time Service. Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: proto: precision = 0.875 usec (-20) Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: Connection closed by client Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1184 days ago Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: MPD server connection closed Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: Listen and drop on 0 v6wildcard [::]:123 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: shairport-sync.service: Succeeded. Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 volumio[23045]: Connection closed by client Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: Listen normally on 2 lo 127.0.0.1:123 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: Listen normally on 3 eth0 192.168.1.222:123 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: Listen normally on 4 wlan0 192.168.50.89:123 Mar 25 01:37:21 ifi-lsq-idsd-phantom1 systemd[1]: upmpdcli.service: Succeeded. Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: Listening on routing socket on fd #21 for interface updates Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Stopped UPnP Renderer front-end to MPD. Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Mar 25 01:37:21 ifi-lsq-idsd-phantom1 ntpd[20883]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Stopping Avahi mDNS/DNS-SD Stack... Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[1007]: Got SIGTERM, quitting. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[1007]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.222. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:22.020 [23499.23499] DEBUG SampleApp: Avahi client state changed: FAILURE Mar 25 01:37:22 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:22.020 [23499.23499] INFO SampleApp: Retarting Avahi advertising, name: lsq iDSD PHANTOM1, service name: _qobuz-connect._tcp Mar 25 01:37:22 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:22.020 [23499.23499] INFO SampleApp: Starting Avahi advertising, name: lsq iDSD PHANTOM1, service name: _qobuz-connect._tcp Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: Browse raised the following error Error: dns service error: unknown Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: error: Discovery: Advertisement error: Error: dns service error: unknown Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: error: Discovery: advertisement error: Error: dns service error: unknown Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: Advertisement raised the following error Error: dns service error: unknown Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[1007]: avahi-daemon 0.7 exiting. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 dbus-daemon[468]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.56' (uid=0 pid=975 comm="/usr/sbin/smbd --foreground --no-process-group ") Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: avahi-daemon.service: Succeeded. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Stopped Avahi mDNS/DNS-SD Stack. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Process 1007 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Successfully dropped root privileges. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: avahi-daemon 0.7 starting up. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 dbus-daemon[468]: [system] Successfully activated service 'org.freedesktop.Avahi' Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Successfully called chroot(). Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Successfully dropped remaining capabilities. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Loading service file /services/volumio.service. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: *** WARNING: Detected another IPv4 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. *** Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.222. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: New relevant interface eth0.IPv4 for mDNS. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Network interface enumeration completed. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Registering new address record for 192.168.1.222 on eth0.IPv4. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Registering HINFO record with values 'AARCH64'/'LINUX'. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:22.128 [23499.23499] DEBUG SampleApp: Avahi client state changed: REGISTERING Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Starting UPnP Renderer front-end to MPD... Mar 25 01:37:22 ifi-lsq-idsd-phantom1 iwconfig[20903]: Error for wireless request "Set Power Management" (8B2C) : Mar 25 01:37:22 ifi-lsq-idsd-phantom1 iwconfig[20903]: SET failed on device wlan0 ; Operation not permitted. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 systemd[1]: Started Wireless Services. Mar 25 01:37:22 ifi-lsq-idsd-phantom1 sudo[19949]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiConfig: {"page":"system_controller/network"} Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: ---------------------------- Client requests Stop Spotify Playback Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: spotify_connect , stopSpotifyPlayback Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: Spotify Connect playback stop Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: Spotify Connect Playback Stopped, clearing state Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::servicePushState Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::resetVolumioState Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::getcurrentVolume Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioRetrievevolume Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:22 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:23 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Server startup complete. Host name is ifi-lsq-idsd-phantom1.local. Local service cookie is 326166162. Mar 25 01:37:23 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:23.015 [23499.23499] DEBUG SampleApp: Avahi client state changed: RUNNING Mar 25 01:37:23 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:23.020 [23499.23499] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Mar 25 01:37:23 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:23.037 [23499.23499] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Mar 25 01:37:23 ifi-lsq-idsd-phantom1 node[476]: avahi-daemon had restarted Mar 25 01:37:23 ifi-lsq-idsd-phantom1 node[476]: avahi-daemon service has restarted Mar 25 01:37:23 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 172.233.157.223 Mar 25 01:37:23 ifi-lsq-idsd-phantom1 ethernet-detect[481]: Updating avahi-daemon configuration: allow-interfaces=eth0,wlan0 Mar 25 01:37:23 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Files changed, reloading. Mar 25 01:37:23 ifi-lsq-idsd-phantom1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 25 01:37:23 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Service "lsq iDSD PHANTOM1" (/services/volumio.service) successfully established. Mar 25 01:37:23 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 155.248.196.28 Mar 25 01:37:23 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:23.936 [23499.23499] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: shairport-sync.service: Succeeded. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Got SIGTERM, quitting. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:24.168 [23499.23499] DEBUG SampleApp: Avahi client state changed: FAILURE Mar 25 01:37:24 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:24.168 [23499.23499] INFO SampleApp: Retarting Avahi advertising, name: lsq iDSD PHANTOM1, service name: _qobuz-connect._tcp Mar 25 01:37:24 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:24.169 [23499.23499] INFO SampleApp: Starting Avahi advertising, name: lsq iDSD PHANTOM1, service name: _qobuz-connect._tcp Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Stopping Avahi mDNS/DNS-SD Stack... Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.222. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: avahi-daemon.service: Succeeded. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[20895]: avahi-daemon 0.7 exiting. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Stopped Avahi mDNS/DNS-SD Stack. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 dbus-daemon[468]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.61' (uid=0 pid=975 comm="/usr/sbin/smbd --foreground --no-process-group ") Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Process 20895 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Successfully dropped root privileges. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: avahi-daemon 0.7 starting up. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 dbus-daemon[468]: [system] Successfully activated service 'org.freedesktop.Avahi' Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Successfully called chroot(). Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Successfully dropped remaining capabilities. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Loading service file /services/volumio.service. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: *** WARNING: Detected another IPv4 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. *** Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.50.89. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: New relevant interface wlan0.IPv4 for mDNS. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.222. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: New relevant interface eth0.IPv4 for mDNS. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Network interface enumeration completed. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Registering new address record for 192.168.50.89 on wlan0.IPv4. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Registering new address record for 192.168.1.222 on eth0.IPv4. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:24.279 [23499.23499] DEBUG SampleApp: Avahi client state changed: REGISTERING Mar 25 01:37:24 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Registering HINFO record with values 'AARCH64'/'LINUX'. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Stopping iFi Streamer mqtt server daemon... Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: ifi-mqtt.service: Main process exited, code=killed, status=15/TERM Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: ifi-mqtt.service: Succeeded. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Stopped iFi Streamer mqtt server daemon. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 systemd[1]: Started iFi Streamer mqtt server daemon. Mar 25 01:37:24 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 23.186.168.129 Mar 25 01:37:24 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 24.144.88.190 Mar 25 01:37:25 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Server startup complete. Host name is ifi-lsq-idsd-phantom1.local. Local service cookie is 3570025449. Mar 25 01:37:25 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:25.101 [23499.23499] DEBUG SampleApp: Avahi client state changed: RUNNING Mar 25 01:37:25 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:25.107 [23499.23499] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Mar 25 01:37:25 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:25.115 [23499.23499] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Mar 25 01:37:25 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 142.202.190.19 Mar 25 01:37:25 ifi-lsq-idsd-phantom1 node[476]: avahi-daemon had restarted Mar 25 01:37:25 ifi-lsq-idsd-phantom1 node[476]: avahi-daemon service has restarted Mar 25 01:37:25 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 144.202.66.214 Mar 25 01:37:25 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 66.42.86.174 Mar 25 01:37:25 ifi-lsq-idsd-phantom1 avahi-daemon[21025]: Service "lsq iDSD PHANTOM1" (/services/volumio.service) successfully established. Mar 25 01:37:25 ifi-lsq-idsd-phantom1 play[23474]: 20260325 01:37:25.967 [23499.23499] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Mar 25 01:37:26 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 198.137.202.56 Mar 25 01:37:26 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 158.51.99.19 Mar 25 01:37:26 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 51.81.226.229 Mar 25 01:37:27 ifi-lsq-idsd-phantom1 systemd[1]: Started UPnP Renderer front-end to MPD. Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Mar 25 01:37:27 ifi-lsq-idsd-phantom1 sudo[21165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:27 ifi-lsq-idsd-phantom1 sudo[21165]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:27 ifi-lsq-idsd-phantom1 sudo[21165]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:27 ifi-lsq-idsd-phantom1 sudo[21168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 25 01:37:27 ifi-lsq-idsd-phantom1 sudo[21168]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:27 ifi-lsq-idsd-phantom1 sudo[21168]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[23045]: New connection from ::ffff:127.0.0.1:45238 Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[23045]: Connected to MPD server Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[23045]: New connection from ::ffff:127.0.0.1:45242 Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[23045]: Connected to MPD server Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[21158]: unable to load Private Key Mar 25 01:37:27 ifi-lsq-idsd-phantom1 volumio[21158]: 4145668112:error:0909006C:PEM routines:get_name:no start line:../crypto/pem/pem_lib.c:745:Expecting: ANY PRIVATE KEY Mar 25 01:37:27 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 173.208.172.164 Mar 25 01:37:27 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 64.79.100.196 Mar 25 01:37:28 ifi-lsq-idsd-phantom1 sudo[21252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 01:37:28 ifi-lsq-idsd-phantom1 sudo[21252]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:28 ifi-lsq-idsd-phantom1 sudo[21252]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:28 ifi-lsq-idsd-phantom1 sudo[21258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:28 ifi-lsq-idsd-phantom1 sudo[21258]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:28 ifi-lsq-idsd-phantom1 sudo[21258]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:28 ifi-lsq-idsd-phantom1 ntpd[20883]: Soliciting pool server 73.185.182.209 Mar 25 01:37:28 ifi-lsq-idsd-phantom1 volumio[23045]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.160 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiConfig: {"page":"system_controller/network"} Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMultiRoomDevices: null Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMultiroom: null Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: error: Could not retrieve plugin audio_interface multiroom Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getAudioOutputs: null Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getState Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getBrowseSources: null Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMenuItems Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiSettings Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getWizard Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getPrivacySettings Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getInfoNetwork Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21266]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21266]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21271]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21271]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21279]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21279]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21285]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21285]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21292]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getWirelessNetworks Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21292]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21295]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21295]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:29 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMenuItems Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 25 01:37:29 ifi-lsq-idsd-phantom1 sudo[21300]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMyVolumioStatus Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getSystemInfo Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: Received Get System Info Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: Getting this device information Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 01:37:30 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getIfiUser: null Mar 25 01:37:31 ifi-lsq-idsd-phantom1 volumio[23045]: info: Volumio Network Manager: Network status updated: 3 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: qobuz_connect , onRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: spotify_connect , onRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: tidal_connect , onRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: error: Could not retrieve plugin audio_interface tidal_connect Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: networkaudiod , onRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21350]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-spotify-connect.service Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21351]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: roon_ready , onRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: error: Could not retrieve plugin music_service roon_ready Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: airplay2 , onRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: error: Could not retrieve plugin music_service airplay2 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: Refreshing Cached IP Addresses Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop networkaudiod.service Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21355]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 node[454]: ConvSwitch: Drop client qobuz-connect Mar 25 01:37:32 ifi-lsq-idsd-phantom1 node[476]: Closing connection with the client qobuz-connect Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21357]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21360]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21351]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21360]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21357]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21350]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21364]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: Stopping Network Audio Adapter daemon... Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: networkaudiod.service: Succeeded. Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: Stopped Network Audio Adapter daemon. Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21364]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21355]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: upmpdcli.service: Succeeded. Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: Connection closed by client Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: Connection closed by client Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: MPD server connection closed Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: MPD server connection closed Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21367]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 systemd[1]: Started Network Audio Adapter daemon. Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21367]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 networkaudiod[21369]: [/usr/sbin/networkaudiod] (21369): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Mar 25 01:37:32 ifi-lsq-idsd-phantom1 networkaudiod[21369]: [/usr/sbin/networkaudiod] (21369): create alsa engine Mar 25 01:37:32 ifi-lsq-idsd-phantom1 networkaudiod[21369]: [/usr/sbin/networkaudiod] (21369): listen discovery on :: Mar 25 01:37:32 ifi-lsq-idsd-phantom1 networkaudiod[21369]: [/usr/sbin/networkaudiod] (21369): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Mar 25 01:37:32 ifi-lsq-idsd-phantom1 networkaudiod[21369]: [/usr/sbin/networkaudiod] (21369): Socket failure, falling back to IPv4-only! Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21371]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: NAA Service Started Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21371]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21373]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21373]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: verbose: New Socket.io Connection to 192.168.1.222 from 192.168.1.160 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Edg/146.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiConfig: {"page":"system_controller/network"} Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMultiRoomDevices: null Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMultiroom: null Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: error: Could not retrieve plugin audio_interface multiroom Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getAudioOutputs: null Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getState Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getBrowseSources: null Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMenuItems Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiSettings Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getWizard Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getPrivacySettings Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getInfoNetwork Mar 25 01:37:32 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21379]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:32 ifi-lsq-idsd-phantom1 sudo[21379]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21384]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21384]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21396]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21396]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21404]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21404]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getWirelessNetworks Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21410]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21410]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21413]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21413]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMenuItems Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21417]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21420]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:33 ifi-lsq-idsd-phantom1 systemd[1]: Started iFi Streamer Qobuz Connect Service. Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21420]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: Qobuz Connect Service Started Mar 25 01:37:33 ifi-lsq-idsd-phantom1 networkaudiod[21369]: [/usr/sbin/networkaudiod] (21369): listen discovery on 0.0.0.0 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Starting sample application Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Device Name: lsq iDSD PHANTOM1 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Manufacturer: Sample manufacturer Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Model: iFi Streamer Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Serial Number: ifi:e2:c3:13:c3:01:9a Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Audio output device: volumio Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Volume control device: default Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Volume control element: Master Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.784 [21439.21439] DEBUG SampleApp: Local config server port: 8000 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: [Info] MetaClient: MetaClient SDK -- v1.03 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 node[476]: A new connection has been established. Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: [Info] MetaClient: MetaClientInit Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 node[454]: ConvSwitch: Add client qobuz-connect Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: [Info] ConvSwitch: ConvSwitchInit Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.892 [21439.21439] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.893 [21439.21439] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: request:setvolume:0,1 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: VolumeController::SetAlsaVolumemute Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:33 ifi-lsq-idsd-phantom1 kernel: mute_store Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21300]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: request:setvolume:0,1 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: VolumeController::SetAlsaVolumemute Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:33 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.931 [21439.21439] DEBUG ActiveStateManager: [0xab3ab9a0]: Creating new Active State Manager Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.931 [21439.21439] DEBUG NetworkActivityTracker: [0xab3aba10]: Creating new Network Activity Tracker Mar 25 01:37:33 ifi-lsq-idsd-phantom1 sudo[21417]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] DEBUG EndpointManager: [0xab3ac988]: Creating Endpoint Manager Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] DEBUG PlaybackSessionManager: [0xab3acd78]: Creating Playback Session Manager Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] DEBUG BackoffTimer: [0xab3acef0]: Creating Backoff Timer Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] DEBUG MediaEngine: [0xab3ad010]: Creating new Media Engine Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] DEBUG AudioRenderer: [0xab3ad230]: Creating Audio Renderer Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] TRACE MediaEngineCommandSequencer: [0xab3ad388]: Creating Media Engine Command Sequencer Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] DEBUG PlaybackControlsManager: [0xab3ad3e8]: Creating new Playback Controls Manager Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.937 [21439.21439] DEBUG VolumeManager: [0xab3ad478]: Creating new Volume Manager Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG ProtocolHandler: [0xab3ad750]: Creating Protocol Handler Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG MessageReceiver: [0xab3ad7f0]: Creating Message Receiver Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG RendererActivationController: [0xab3ad968]: Creating new Renderer Activation Controller Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] TRACE RendererActivationCommandSequencer: [0xab3ada10]: Creating Renderer Activation Command Sequencer Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG ReportingManager: [0xab3adb20]: Creating new Reporting Manager Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG StreamingEventReporter: [0xab3adb68]: Creating Streaming Event Reporter Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG BackoffTimer: [0xab3adc48]: Creating Backoff Timer Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG TokenExpiryController: [0xab3add58]: Creating Token Expiry Controller Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG UserInactivityManager: [0xab3adda8]: Creating new User Inactivity Manager Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] INFO VolumeManager: [0xab3ad478]: Setting new playback volume: 100 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] INFO VolumeManager: [0xab3ad478]: Setting new mute state: 1 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] DEBUG SampleApp: Qobuz Connect has been initialized Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] TRACE SampleApp: Running event loop Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] INFO QobuzConnect: [0xab3ade48]: Client initialized! Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.938 [21439.21439] INFO SampleApp: Starting Avahi advertising, name: lsq iDSD PHANTOM1, service name: _qobuz-connect._tcp Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.952 [21439.21439] DEBUG SampleApp: Avahi client state changed: RUNNING Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.956 [21439.21439] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.962 [21439.21439] INFO LocalConfigManager: [0xab3acd58]: Starting Local Configuration server Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.962 [21439.21439] INFO SampleApp: Starting Local configuration server Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.964 [21439.21439] INFO SampleApp: Playback mute state changed: 1 Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.964 [21439.21439] ERROR SampleApp: Unable to set mute state, no ALSA volume element Mar 25 01:37:33 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:33.964 [21439.21439] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Mar 25 01:37:34 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:34.036 [21439.21439] INFO SampleApp: Playback volume changed: 100 Mar 25 01:37:34 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:34.036 [21439.21439] ERROR SampleApp: Unable to set volume, no ALSA volume element Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMyVolumioStatus Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getSystemInfo Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: Received Get System Info Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: Getting this device information Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 01:37:34 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getIfiUser: null Mar 25 01:37:34 ifi-lsq-idsd-phantom1 play[21422]: 20260325 01:37:34.817 [21439.21439] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Mar 25 01:37:35 ifi-lsq-idsd-phantom1 sudo[21494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Mar 25 01:37:35 ifi-lsq-idsd-phantom1 sudo[21494]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 systemd[1]: Started iFi Streamer Spotify Connect Service. Mar 25 01:37:35 ifi-lsq-idsd-phantom1 sudo[21494]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:35 ifi-lsq-idsd-phantom1 volumio[23045]: info: Spotify Connect Service Started Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: iDSD_PHANTOM Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: output: volumio mixer: hw:0 Mar 25 01:37:35 ifi-lsq-idsd-phantom1 node[476]: A new connection has been established. Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.798 I api :141 SpRegisterDebugCallbacks SpRegisterDebugCallbacks [returned value: 0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 I api :57 SpInit SpInit(0xffdb5430, API v85) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 I esdk :1740 esdkSpInit eSDK version: esdk-v3.211-v3.211.126-g38bc1087 Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk :256 sp_korn_request_memory_block Module requested 600 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk :256 sp_korn_request_memory_block Module requested 184 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk :256 sp_korn_request_memory_block Module requested 200 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk :358 sp_korn_init_module Initializing module SocketManager Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk :256 sp_korn_request_memory_block Module requested 112 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk :358 sp_korn_init_module Initializing module API Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk :256 sp_korn_request_memory_block Module requested 3560 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :358 sp_korn_init_module Initializing module MediaOut Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 136 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 2344 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 40 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 976 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 D esdk api :2005 sp_module_media_out_init raise EXTERNAL_STUTTERS_POINTER Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 D esdk api :2007 sp_module_media_out_init raise PREVIOUS_POSITION Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :358 sp_korn_init_module Initializing module APConn Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 26784 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 25160 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 56 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 1040 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 D esdk api :1140 sp_module_ap_conn_init raise AP_CREATED Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :358 sp_korn_init_module Initializing module Streamer Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :256 sp_korn_request_memory_block Module requested 8472 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 D esdk api :1419 sp_module_streamer_init raise STREAMER_TRACK_PERCENTAGE Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.799 T esdk api :358 sp_korn_init_module Initializing module TrackPlayback Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk api :256 sp_korn_request_memory_block Module requested 214848 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 D esdk api :3390 sp_module_track_playback_init raise TPAPI_SHARED_STATE_POINTER Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk api :358 sp_korn_init_module Initializing module mDNS Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T zc api :39 sp_module_mdns_init Request memory block of 1 KiB for mDNS module Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk api :256 sp_korn_request_memory_block Module requested 1536 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk api :358 sp_korn_init_module Initializing module WebServer Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T zc api :34 sp_module_webserver_init Request memory block of 2 KiB for webserver module Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk api :256 sp_korn_request_memory_block Module requested 2048 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk api :358 sp_korn_init_module Initializing module ZeroConfServer Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T zc api :21 sp_module_zeroconf_init Request memory block of 0 KiB for zeroconf module Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk api :256 sp_korn_request_memory_block Module requested 8 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 I esdk api :353 register_socket_callbacks Successfully registered socket callbacks: cre, set_opt, cl, bind, list, con, acc, rd, wr, rd_from, wr_to, err, readable, writable, local_addresses, address, pump Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 I esdk api :333 register_dns_callbacks Successfully registered dns callback: dns_lookup_callback Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 D esdk event:EXTERNAL_STUTTERS_POINTER :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 D esdk event:PREVIOUS_POSITION :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 D esdk event:AP_CREATED :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 D esdk event:STREAMER_TRACK_PERCENTAGE :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 D esdk event:TPAPI_SHARED_STATE_POINTE :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 D esdk event:KORN_INITIALIZED :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 I download event:KORN_INITIALIZED :211 alloc_circular_buffer Using 128 kB for cache buffer Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.800 T esdk event:KORN_INITIALIZED :256 sp_korn_request_memory_block Module requested 131072 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.801 I download event:KORN_INITIALIZED :211 alloc_circular_buffer Using 606 kB for compressed audio buffer Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.801 T esdk event:KORN_INITIALIZED :256 sp_korn_request_memory_block Module requested 621104 bytes Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.801 I api api :1295 SpGetDefaultSocketHALCallbacks SpGetDefaultSocketHALCallbacks() Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.801 I api api :1297 SpGetDefaultSocketHALCallbacks SpGetDefaultSocketHALCallbacks [returned value: 0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 D esdk api :1798 esdkSpInit raise REDELIVER_AUDIO_AT_RESUME Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 I esdk api :445 register_error_callbacks Successfully registered error callback Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 D esdk api :1809 esdkSpInit raise SET_VOLUME Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 D esdk api :1812 esdkSpInit raise VOLUME_STEPS Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 D esdk api :3510 esdkSpSetDisplayName raise CONNECT_NAME Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 D esdk api :1519 save_session_config raise GROUP_STATE Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 D esdk api :1845 esdkSpInit raise UPDATE_CAPABILITIES Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.809 D esdk api :1866 esdkSpInit raise CONNECTIVITY Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk api :1889 esdkSpInit raise HOSTNAME Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk api :1897 esdkSpInit raise UPDATE_ALIASES Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk api :1899 esdkSpInit raise ZEROCONF_START Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk api :1921 esdkSpInit raise REQUEST_BITRATE Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk api :1924 esdkSpInit raise DISABLE_CONNECT Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk api :1927 esdkSpInit raise INIT_DONE Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk event:REDELIVER_AUDIO_AT_RESUME :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk event:SET_VOLUME :466 sp_korn_dispatch_event [32768] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk event:VOLUME_STEPS :466 sp_korn_dispatch_event [16] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk event:CONNECT_NAME :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk event:GROUP_STATE :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 D esdk event:UPDATE_CAPABILITIES :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.821 I esdk event:UPDATE_CAPABILITIES :2921 track_playback_event Updated capabilities = 1, updated formats = 1 Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:CONNECTIVITY :466 sp_korn_dispatch_event [1] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:CONNECTIVITY :1088 ap_conn_event raise CONNECTION_STATE_CHANGED Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:HOSTNAME :466 sp_korn_dispatch_event [17] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:UPDATE_ALIASES :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:ZEROCONF_START :466 sp_korn_dispatch_event [364773376] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:ZEROCONF_START :48 zeroconf_mod_event raise WEBSERVER_START Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:REQUEST_BITRATE :466 sp_korn_dispatch_event [3] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 T audio event:REQUEST_BITRATE :54 get_pos_from_integration track_id 0, provided_to_integration 0, is_seeking 0 Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:DISABLE_CONNECT :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:INIT_DONE :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:CONNECTION_STATE_CHANGED :466 sp_korn_dispatch_event [1] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 I esdk event:CONNECTION_STATE_CHANGED :569 handle_connection_state_change Connection state changed: 1 -> 1 Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:CONNECTION_STATE_CHANGED :125 webserver_mod_event raise WEBSERVER_UPDATED Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:WEBSERVER_START :466 sp_korn_dispatch_event [364773376] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 I esdk event:WEBSERVER_START :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 E esdk event:WEBSERVER_START :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 E esdk event:WEBSERVER_START :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 I zc event:WEBSERVER_START :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 T zc event:WEBSERVER_START :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 D esdk event:WEBSERVER_UPDATED :466 sp_korn_dispatch_event [0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 I api api :59 SpInit SpInit [returned value: 0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.822 I api api :91 SpRegisterConnectionCallbacks SpRegisterConnectionCallbacks(0xffdb5424, (nil)) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.823 I esdk api :271 register_connection_callbacks Successfully registered connection callbacks: on_notify, on_message, - Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.823 I api api :93 SpRegisterConnectionCallbacks SpRegisterConnectionCallbacks [returned value: 0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.823 I api api :115 SpRegisterPlaybackCallbacks SpRegisterPlaybackCallbacks(0xffdb5414, (nil)) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.823 I esdk api :184 register_playback_callbacks Successfully registered playback callbacks: on_notify, -, on_apply_volume Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.823 I api api :117 SpRegisterPlaybackCallbacks SpRegisterPlaybackCallbacks [returned value: 0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.829 W app api /usr/src/app/volumio3/spotify/spotify-connect/examples/common/audio/linux_alsa.c:446 audio_init Couldn't find mixer for volume controls. (tried Master, PCM, Digital) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.829 I api api :127 SpRegisterStreamCallbacks SpRegisterStreamCallbacks(0xffdb4460, 0x368a0) Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.829 I esdk api :203 register_stream_callbacks Successfully registered delivery callbacks: on_start, on_data, on_pos, on_seek, on_flush, on_end Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.829 I api api :129 SpRegisterStreamCallbacks SpRegisterStreamCallbacks [returned value: 0] Mar 25 01:37:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:35.829 I app api /usr/src/app/volumio3/spotify/spotify-connect/examples/example_delivery.c:272 main Initialized! Mar 25 01:37:36 ifi-lsq-idsd-phantom1 kernel: unmute_store Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: request:setvolume:0,0 Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.072 I api api :275 SpPlaybackUpdateVolume SpPlaybackUpdateVolume(0) Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.072 D esdk api :2387 esdkSpPlaybackUpdateVolume raise SET_VOLUME Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.072 D esdk event:SET_VOLUME :466 sp_korn_dispatch_event [0] Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.072 I app event:SET_VOLUME /usr/src/app/volumio3/spotify/spotify-connect/examples/example_delivery.c:498 CallbackPlaybackApplyVolume Playback status: volume now 0 Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.072 I api api :279 SpPlaybackUpdateVolume SpPlaybackUpdateVolume [returned value: 0] Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: request:setvolume:15,0 Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: VolumeController::SetAlsaVolume15 Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: MetaClient: Get message: request:setvolume:16,0 Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: VolumeController::SetAlsaVolume16 Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::pushState Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioPushState Mar 25 01:37:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.840 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.840 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.840 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.840 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:36.840 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:37.845 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:37.845 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:37.845 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:37.845 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:37.845 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:38.851 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:38.851 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:38.851 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:38.852 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:38.852 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:39.856 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:39.856 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:39.857 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:39.857 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:39.857 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:40.863 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:40.863 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:40.863 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:40.863 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:40.863 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:41.869 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:41.869 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:41.869 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:41.869 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:41.869 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21596]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21596]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21597]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21597]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart upmpdcli.service Mar 25 01:37:42 ifi-lsq-idsd-phantom1 sudo[21601]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 25 01:37:42 ifi-lsq-idsd-phantom1 systemd[1]: Starting UPnP Renderer front-end to MPD... Mar 25 01:37:42 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:42.875 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:42 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:42.875 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:42 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:42.875 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:42 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:42.875 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:42 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:42.875 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:43 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:43.877 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:43 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:43.878 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:43 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:43.878 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:43 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:43.878 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:43 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:43.878 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:44 ifi-lsq-idsd-phantom1 volumiologrotate[480]: ls: cannot access '/var/log/samba/log.wb-LSQ': No such file or directory Mar 25 01:37:44 ifi-lsq-idsd-phantom1 volumiologrotate[480]: ls: cannot access 'IDSD': No such file or directory Mar 25 01:37:44 ifi-lsq-idsd-phantom1 volumiologrotate[480]: ls: cannot access 'PHANTOM1': No such file or directory Mar 25 01:37:44 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:44.883 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:44 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:44.883 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:44 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:44.883 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:44 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:44.884 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:44 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:44.884 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:45 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:45.887 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:45 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:45.888 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:45 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:45.888 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:45 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:45.888 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:45 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:45.888 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:46 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:46.891 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:46 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:46.891 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:46 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:46.891 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:46 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:46.891 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:46 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:46.891 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:47 ifi-lsq-idsd-phantom1 systemd[1]: Started UPnP Renderer front-end to MPD. Mar 25 01:37:47 ifi-lsq-idsd-phantom1 sudo[21601]: pam_unix(sudo:session): session closed for user root Mar 25 01:37:47 ifi-lsq-idsd-phantom1 volumio[23045]: info: Upmpdcli Daemon Started Mar 25 01:37:47 ifi-lsq-idsd-phantom1 volumio[23045]: New connection from ::ffff:127.0.0.1:45250 Mar 25 01:37:47 ifi-lsq-idsd-phantom1 volumio[23045]: Connected to MPD server Mar 25 01:37:47 ifi-lsq-idsd-phantom1 volumio[23045]: New connection from ::ffff:127.0.0.1:45254 Mar 25 01:37:47 ifi-lsq-idsd-phantom1 volumio[23045]: Connected to MPD server Mar 25 01:37:47 ifi-lsq-idsd-phantom1 volumio[21722]: unable to load Private Key Mar 25 01:37:47 ifi-lsq-idsd-phantom1 volumio[21722]: 4148465680:error:0909006C:PEM routines:get_name:no start line:../crypto/pem/pem_lib.c:745:Expecting: ANY PRIVATE KEY Mar 25 01:37:47 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:47.896 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:47 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:47.897 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:47 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:47.897 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:47 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:47.897 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:47 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:47.897 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:48 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:48.900 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:48 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:48.900 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:48 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:48.900 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:48 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:48.900 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:48 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:48.900 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:49 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:49.902 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:49 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:49.902 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:49 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:49.902 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:49 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:49.903 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:49 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:49.903 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:50 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:50.912 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:50 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:50.912 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:50 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:50.912 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:50 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:50.912 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:50 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:50.912 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getPrivacySettings Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ callMethod: {"type":"plugin","endpoint":"system_controller/my_volumio","method":"retreiveBackendEventStates"} Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: error: Could not retrieve plugin system_controller my_volumio Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getSystemVersion Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: Received Get System Version Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getSystemInfo Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: Received Get System Info Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: Discovery: Getting this device information Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:51 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 01:37:51 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:51.915 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:51 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:51.918 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:51 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:51.918 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:51 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:51.918 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:51 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:51.918 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:52 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:52.924 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:52 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:52.924 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:52 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:52.925 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:52 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:52.925 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:52 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:52.925 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:53 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:53.926 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:53 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:53.926 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:53 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:53.926 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:53 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:53.926 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:53 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:53.926 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: verbose: New Socket.io Connection to 192.168.50.89 from 192.168.50.79 UA: unknown Engine version: 3 Transport: websocket Total Clients: 4 Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getState Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::getQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CorePlayQueue::getQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getBrowseSources: undefined Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiConfig: {"page":"system_controller/system"} Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMenuItems Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"radio/bbc"} Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: Getting BBC Radios Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: verbose: New Socket.io Connection to 192.168.50.89 from 192.168.50.30 UA: unknown Engine version: 3 Transport: websocket Total Clients: 5 Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getState Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetState Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::getQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CorePlayQueue::getQueue Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getBrowseSources: undefined Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetVisibleSources Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getUiConfig: {"page":"system_controller/system"} Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getMenuItems Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"music-library/USB"} Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: music-library/USB Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 25 01:37:54 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Mar 25 01:37:54 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:54.931 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:54 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:54.931 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:54 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:54.931 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:54 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:54.931 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:54 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:54.931 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:55 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:37:55 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:55.934 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:55 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:55.934 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:55 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:55.934 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:55 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:55.934 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:55 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:55.934 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:56 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:56.943 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:56 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:56.943 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:56 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:56.943 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:56 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:56.943 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:56 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:56.943 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:57 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:57.945 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:57 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:57.945 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:57 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:57.945 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:57 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:57.946 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:57 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:57.946 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:58 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:58.954 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:58 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:58.955 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:58 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:58.955 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:58 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:58.955 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:58 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:58.955 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:37:59 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:59.956 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:37:59 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:59.956 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:37:59 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:59.956 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:37:59 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:59.956 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:37:59 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:37:59.956 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:00 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:00.958 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:00 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:00.958 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:00 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:00.958 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:00 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:00.959 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:00 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:00.959 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:01 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:01.960 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:01 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:01.963 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:01 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:01.963 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:01 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:01.963 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:01 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:01.963 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:02 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:02.968 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:02 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:02.971 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:02 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:02.971 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:02 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:02.971 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:02 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:02.971 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:03 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:03.972 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:03 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:03.975 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:03 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:03.976 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:03 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:03.977 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:03 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:03.977 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:04 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:04.979 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:04 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:04.980 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:04 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:04.980 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:04 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:04.980 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:04 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:04.980 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:05 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:05.982 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:05 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:05.988 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:05 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:05.989 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:05 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:05.989 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:05 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:05.989 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"music-library/NAS"} Mar 25 01:38:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: music-library/NAS Mar 25 01:38:06 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:06 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:06.990 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:06 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:06.990 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:06 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:06.991 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:06 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:06.991 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:06 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:06.991 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:07 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:07.994 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:07 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:07.995 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:07 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:07.995 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:07 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:07.995 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:07 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:07.995 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:09 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:09.000 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:09 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:09.003 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:09 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:09.003 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:09 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:09.003 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:09 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:09.003 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:10 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:10.003 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:10 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:10.006 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:10 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:10.007 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:10 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:10.007 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:10 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:10.008 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"music-library/NAS/192.168.1.10"} Mar 25 01:38:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: music-library/NAS/192.168.1.10 Mar 25 01:38:10 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:11 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:11.010 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:11 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:11.010 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:11 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:11.010 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:11 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:11.011 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:11 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:11.011 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:12 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:12.011 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:12 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:12.011 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:12 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:12.011 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:12 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:12.011 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:12 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:12.011 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:13 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:13.018 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:13 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:13.021 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:13 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:13.021 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:13 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:13.021 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:13 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:13.021 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:13 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"artists://"} Mar 25 01:38:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: artists:// Mar 25 01:38:14 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:14.023 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:14 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:14.025 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:14 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:14.026 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:14 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:14.026 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:14 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:14.026 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:14 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:15 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:15.030 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:15 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:15.030 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:15 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:15.030 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:15 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:15.030 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:15 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:15.030 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:16 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:16.031 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:16 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:16.031 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:16 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:16.031 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:16 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:16.031 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:16 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:16.031 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:17 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:17.042 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:17 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:17.042 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:17 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:17.042 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:17 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:17.043 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:17 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:17.043 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:18 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:18.047 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:18 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:18.047 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:18 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:18.047 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:18 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:18.048 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:18 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:18.048 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:19 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:19.052 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:19 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:19.053 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:19 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:19.053 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:19 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:19.053 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:19 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:19.053 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:20 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:20.056 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:20 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:20.056 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:20 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:20.056 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:20 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:20.056 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:20 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:20.056 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:21 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:21.060 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:21 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:21.060 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:21 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:21.061 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:21 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:21.061 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:21 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:21.061 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:22 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:22.065 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:22 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:22.065 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:22 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:22.065 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:22 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:22.065 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:22 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:22.065 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:23 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:23.069 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:23 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:23.069 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:23 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:23.069 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:23 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:23.069 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:23 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:23.069 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:24 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:24.072 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:24 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:24.073 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:24 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:24.073 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:24 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:24.073 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:24 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:24.073 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:25 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:25.080 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:25 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:25.081 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:25 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:25.081 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:25 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:25.081 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:25 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:25.081 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:26 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:26.085 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:26 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:26.085 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:26 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:26.085 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:26 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:26.085 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:26 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:26.085 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:26 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"albums://"} Mar 25 01:38:26 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:26 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: albums:// Mar 25 01:38:26 ifi-lsq-idsd-phantom1 volumio[23045]: info: listAlbums - loading Albums from cache Mar 25 01:38:26 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:27 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:27.088 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:27 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:27.088 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:27 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:27.088 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:27 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:27.088 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:27 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:27.088 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:28 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:28.091 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:28 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:28.091 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:28 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:28.091 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:28 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:28.091 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:28 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:28.091 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:29 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:29.097 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:29 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:29.097 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:29 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:29.097 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:29 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:29.097 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:29 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:29.097 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:30 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:30.103 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:30 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:30.103 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:30 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:30.104 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:30 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:30.104 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:30 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:30.104 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:31 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:31.113 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:31 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:31.113 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:31 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:31.113 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:31 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:31.113 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:31 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:31.113 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:32 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:32.114 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:32 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:32.114 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:32 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:32.114 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:32 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:32.114 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:32 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:32.114 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:33 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:33.115 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:33 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:33.115 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:33 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:33.115 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:33 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:33.115 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:33 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:33.115 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:34 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:34.116 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:34 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:34.116 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:34 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:34.116 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:34 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:34.116 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:34 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:34.116 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:35 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"artists://"} Mar 25 01:38:35 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:35 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: artists:// Mar 25 01:38:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:35.119 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:35.119 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:35.119 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:35.119 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:35 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:35.119 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:35 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:36.124 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:36.124 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:36.124 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:36.124 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:36 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:36.124 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"playlists"} Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: playlists Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: Listing playlists Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ getQueue Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::volumioGetQueue Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreStateMachine::getQueue Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: CorePlayQueue::getQueue Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ listPlaylist: null Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: Listing playlists Mar 25 01:38:36 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:37.130 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:37.131 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:37.131 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:37.131 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:37 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:37.131 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:38.138 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:38.139 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:38.139 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:38.139 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:38 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:38.139 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:38 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"artists://"} Mar 25 01:38:38 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:38 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: artists:// Mar 25 01:38:38 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:39.145 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:39.145 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:39.146 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:39.146 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:39 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:39.146 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"albums://"} Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: albums:// Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: listAlbums - loading Albums from cache Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: ++++--++++ browseLibrary: {"uri":"music-library"} Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 01:38:39 ifi-lsq-idsd-phantom1 volumio[23045]: info: CURURI: music-library Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: info: Preload queue cleared Mar 25 01:38:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:40.152 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:40.153 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:40.153 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:40.153 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:40 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:40.153 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: TypeError: Cannot read property 'slice' of null Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at Object.onceWrapper (events.js:520:26) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at ClientRequest.emit (events.js:400:28) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at TLSSocket.socketOnData (_http_client.js:515:22) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at TLSSocket.emit (events.js:400:28) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at addChunk (internal/streams/readable.js:293:12) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at readableAddChunk (internal/streams/readable.js:267:9) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Mar 25 01:38:40 ifi-lsq-idsd-phantom1 volumio[23045]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 01:38:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:41.158 I esdk pump:WebServer :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Mar 25 01:38:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:41.158 E esdk pump:WebServer :295 CallbackSocketBind Socket bind error: 98 Mar 25 01:38:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:41.158 E esdk pump:WebServer :107 socket_listen_tcp listen socket_bind ret: -10002, closing socket Mar 25 01:38:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:41.158 I zc pump:WebServer :480 webserver_initialize webserver: Unable to create socket Mar 25 01:38:41 ifi-lsq-idsd-phantom1 play[21496]: 2026-03-25 01:38:41.158 T zc pump:WebServer :60 webserver_mod_start webserver_initialize() = (nil) Mar 25 01:38:41 ifi-lsq-idsd-phantom1 sudo[22478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-25 01:37 Mar 25 01:38:41 ifi-lsq-idsd-phantom1 sudo[22478]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5cecc319019273a176f5b9d24136c7b807d78c68" VOLUMIO_FE_VERSION="23ff62fcd606a28c68b20343086e06545bf7f8af" VOLUMIO_FE3_VERSION="1a94468a1e8ac581df397d0058be47d5d42121c7" VOLUMIO_BE_VERSION="5154b32e57d2f24696c257c89c44ed0f855fb798" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 16:29:08 CST 2026" VOLUMIO_VERSION="2.03.2" VOLUMIO_HARDWARE="idsd-phantom" VOLUMIO_DEVICENAME="iDSD PHANTOM" VOLUMIO_HASH="d8a393f9f7636b23d97a6293f4ad2db4"