-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2026-02-25 17:30:28 CST. -- Feb 25 17:29:16 volumio4 kernel: usb 1-1.4: new low-speed USB device number 4 using dwc2 Feb 25 17:29:16 volumio4 kernel: usb 1-1.4: New USB device found, idVendor=09da, idProduct=8736 Feb 25 17:29:16 volumio4 kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Feb 25 17:29:16 volumio4 kernel: usb 1-1.4: Product: USB Mouse Feb 25 17:29:16 volumio4 kernel: usb 1-1.4: Manufacturer: SIGMACHIP Feb 25 17:29:16 volumio4 kernel: input: SIGMACHIP USB Mouse as /devices/platform/ff540000.usb/usb1/1-1/1-1.4/1-1.4:1.0/0003:09DA:8736.0002/input/input4 Feb 25 17:29:16 volumio4 kernel: hid-generic 0003:09DA:8736.0002: input,hidraw1: USB HID v1.10 Mouse [SIGMACHIP USB Mouse] on usb-ff540000.usb-1.4/input0 Feb 25 17:29:16 volumio4 systemd-udevd[2136]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 25 17:29:19 volumio4 kernel: usb 1-1.1: new low-speed USB device number 5 using dwc2 Feb 25 17:29:20 volumio4 kernel: usb 1-1.1: New USB device found, idVendor=1c4f, idProduct=0002 Feb 25 17:29:20 volumio4 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Feb 25 17:29:20 volumio4 kernel: usb 1-1.1: Product: USB Keyboard Feb 25 17:29:20 volumio4 kernel: usb 1-1.1: Manufacturer: SIGMACHIP Feb 25 17:29:20 volumio4 kernel: input: SIGMACHIP USB Keyboard as /devices/platform/ff540000.usb/usb1/1-1/1-1.1/1-1.1:1.0/0003:1C4F:0002.0003/input/input5 Feb 25 17:29:20 volumio4 kernel: hid-generic 0003:1C4F:0002.0003: input,hidraw2: USB HID v1.10 Keyboard [SIGMACHIP USB Keyboard] on usb-ff540000.usb-1.1/input0 Feb 25 17:29:20 volumio4 kernel: input: SIGMACHIP USB Keyboard as /devices/platform/ff540000.usb/usb1/1-1/1-1.1/1-1.1:1.1/0003:1C4F:0002.0004/input/input6 Feb 25 17:29:20 volumio4 kernel: hid-generic 0003:1C4F:0002.0004: input,hidraw3: USB HID v1.10 Device [SIGMACHIP USB Keyboard] on usb-ff540000.usb-1.1/input1 Feb 25 17:29:20 volumio4 systemd-udevd[2170]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 25 17:29:20 volumio4 systemd-logind[562]: Watching system buttons on /dev/input/event5 (SIGMACHIP USB Keyboard) Feb 25 17:29:20 volumio4 systemd-udevd[2137]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 25 17:29:20 volumio4 systemd-logind[562]: Watching system buttons on /dev/input/event6 (SIGMACHIP USB Keyboard) Feb 25 17:29:28 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:29:28 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 25 17:29:29 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 25 17:29:29 volumio4 sudo[2203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 25 17:29:29 volumio4 sudo[2208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 25 17:29:29 volumio4 sudo[2203]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:29 volumio4 sudo[2215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 25 17:29:29 volumio4 sudo[2208]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:29 volumio4 sudo[2203]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:29 volumio4 sudo[2215]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:29 volumio4 sudo[2222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 25 17:29:29 volumio4 sudo[2208]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:29 volumio4 sudo[2236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:29:29 volumio4 sudo[2222]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:29 volumio4 sudo[2215]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:29 volumio4 sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:29 volumio4 sudo[2222]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:29 volumio4 sudo[2244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:29:29 volumio4 sudo[2236]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:29 volumio4 sudo[2244]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:29 volumio4 sudo[2244]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:29 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 25 17:29:29 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 25 17:29:29 volumio4 sudo[2279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 25 17:29:29 volumio4 sudo[2279]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:30 volumio4 sudo[2279]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:46 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:46 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:46 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:46 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:46 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:46 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:46 volumio4 volumio[1153]: verbose: New Socket.io Connection to 192.168.31.232:3000 from 192.168.31.102 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 25 17:29:46 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 17:29:46 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 17:29:46 volumio4 volumio[1153]: verbose: New Socket.io Connection to 192.168.31.232:3000 from 192.168.31.102 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 25 17:29:47 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:47 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:47 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:47 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:47 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:47 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:48 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:48 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 25 17:29:48 volumio4 sudo[2361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 25 17:29:48 volumio4 sudo[2361]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:48 volumio4 sudo[2366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 25 17:29:48 volumio4 sudo[2375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 25 17:29:48 volumio4 sudo[2361]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:48 volumio4 sudo[2366]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:48 volumio4 sudo[2380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 25 17:29:48 volumio4 sudo[2386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:29:48 volumio4 sudo[2366]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:48 volumio4 sudo[2375]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:48 volumio4 sudo[2386]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:48 volumio4 sudo[2380]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:48 volumio4 sudo[2394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:29:48 volumio4 sudo[2375]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:48 volumio4 sudo[2386]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:48 volumio4 sudo[2380]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:48 volumio4 sudo[2394]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:48 volumio4 sudo[2394]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:48 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:48 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:48 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:48 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:48 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 17:29:48 volumio4 volumio[1153]: verbose: New Socket.io Connection to 192.168.31.232:3000 from 192.168.31.102 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 17:29:48 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 17:29:49 volumio4 sudo[2435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:29:49 volumio4 sudo[2435]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:49 volumio4 sudo[2437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:29:49 volumio4 sudo[2435]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:49 volumio4 sudo[2437]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:49 volumio4 sudo[2437]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:49 volumio4 volumio[1153]: verbose: New Socket.io Connection to 192.168.31.232 from 192.168.31.102 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Feb 25 17:29:49 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 17:29:50 volumio4 sudo[2455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 17:29:50 volumio4 sudo[2457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 17:29:50 volumio4 sudo[2455]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:50 volumio4 sudo[2455]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:50 volumio4 sudo[2457]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:29:50 volumio4 sudo[2457]: pam_unix(sudo:session): session closed for user root Feb 25 17:29:50 volumio4 volumio[1153]: verbose: New Socket.io Connection to 192.168.31.232 from 192.168.31.102 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:50 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 25 17:29:50 volumio4 volumio[1153]: info: Received Get System Info Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:50 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:50 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:50 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:50 volumio4 volumio[1153]: info: Listing playlists Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 17:29:50 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 17:29:51 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 25 17:29:51 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 17:29:51 volumio4 volumio[1153]: info: Received Get System Info Feb 25 17:29:51 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:51 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:51 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:51 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:51 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:51 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPlay Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::play index undefined Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::startPlaybackTimer Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::clearAddPlayTracks USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand stop took 2 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand clear took 0 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand add "USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav" Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:29:53 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:29:53 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand add "USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav" took 3 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand play Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:29:53 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:29:53 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces state update: player Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 15ms Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 14ms Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand play took 13 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:29:53 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces state update: player Feb 25 17:29:53 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:29:53 volumio4 volumio[1153]: error: Upnp client error: Error: This socket has been ended by the other party Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 20ms Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 13ms Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand status took 17 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 17ms Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand status took 16 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:29:53 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:29:53 volumio4 volumio[1153]: info: Feb 25 17:29:53 volumio4 volumio[1153]: ---------------------------- MPD announces state update: player Feb 25 17:29:53 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand clearerror took 17 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand clearerror took 15 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 7ms Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand status took 4 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::parseTrackInfo Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::parseTrackInfo Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 17:29:53 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(01) [張學友] 吻別.wav","artist":null,"album":null,"uri":"USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav","trackType":"wav"} Feb 25 17:29:53 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: No code Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(01) [張學友] 吻別.wav","artist":null,"album":null,"uri":"USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav","trackType":"wav"} Feb 25 17:29:53 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: No code Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 122ms Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 118ms Feb 25 17:29:53 volumio4 volumio[1153]: info: sendMpdCommand playlistinfo took 90 milliseconds Feb 25 17:29:53 volumio4 volumio[1153]: verbose: ControllerMpd::parseTrackInfo Feb 25 17:29:53 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(01) [張學友] 吻別.wav","artist":null,"album":null,"uri":"USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav","trackType":"wav"} Feb 25 17:29:53 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: No code Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:29:53 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:53 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:29:53 volumio4 volumio[1153]: info: ------------------------------ 145ms Feb 25 17:29:56 volumio4 volumio[1153]: verbose: New Socket.io Connection to 192.168.31.232:3000 from 192.168.31.102 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Feb 25 17:29:56 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 17:29:56 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 17:29:56 volumio4 volumio[1153]: info: Discovery: Getting this device information Feb 25 17:29:56 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:29:56 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:29:56 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 25 17:29:59 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 25 17:30:00 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 25 17:30:03 volumio4 volumio[1153]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Feb 25 17:30:03 volumio4 volumio[1153]: info: Preparing to save Alsa Options, stopping services first Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetState Feb 25 17:30:03 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPause Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreStateMachine::pause Feb 25 17:30:03 volumio4 volumio[1153]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"SDAC"}} Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 17:30:03 volumio4 volumio[1153]: info: Setting mixer SDAC for card SDAC Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 25 17:30:03 volumio4 volumio[1153]: info: Updating Volume Controller Parameters: Device: 5 Name: SDAC Mixer: SDAC Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 25 17:30:03 volumio4 volumio[1153]: info: Disabling external Volume Control Feb 25 17:30:03 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:30:03 volumio4 volumio[1153]: info: Preparing to generate the ALSA configuration file Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 25 17:30:04 volumio4 volumio[1153]: info: Asound.conf file written Feb 25 17:30:04 volumio4 sudo[2527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 25 17:30:04 volumio4 sudo[2527]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 sudo[2527]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:04 volumio4 volumio[1153]: No state is present for card SDAC Feb 25 17:30:04 volumio4 volumio[1153]: Found hardware: "USB-Audio" "USB Mixer" "USB21b4:0144" "" "" Feb 25 17:30:04 volumio4 volumio[1153]: Hardware is initialized using a generic method Feb 25 17:30:04 volumio4 volumio[1153]: No state is present for card SDAC Feb 25 17:30:04 volumio4 volumio[1153]: info: Output device has changed, restarting MPD Feb 25 17:30:04 volumio4 volumio[1153]: info: Output device has changed, restarting Shairport Sync Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:30:04 volumio4 sudo[2539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 17:30:04 volumio4 sudo[2541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 17:30:04 volumio4 sudo[2539]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 sudo[2539]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:04 volumio4 sudo[2541]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 17:30:04 volumio4 volumio[1153]: info: Output device has changed, restarting MPD Feb 25 17:30:04 volumio4 systemd[1]: Stopping Music Player Daemon... Feb 25 17:30:04 volumio4 volumio[1153]: info: Output device has changed, restarting Shairport Sync Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:30:04 volumio4 sudo[2559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 17:30:04 volumio4 sudo[2562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 17:30:04 volumio4 sudo[2559]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 sudo[2559]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:04 volumio4 sudo[2562]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 17:30:04 volumio4 volumio[1153]: info: MPD Permissions set Feb 25 17:30:04 volumio4 volumio[1153]: info: VolumeController:: Volume=100 Mute =false Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:04 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:04 volumio4 systemd[1]: mpd.service: Succeeded. Feb 25 17:30:04 volumio4 systemd[1]: Stopped Music Player Daemon. Feb 25 17:30:04 volumio4 systemd[1]: Starting Music Player Daemon... Feb 25 17:30:04 volumio4 volumio[1153]: info: MPD Permissions set Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 17:30:04 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:04 volumio4 sudo[2578]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 25 17:30:04 volumio4 volumio[1153]: info: Starting Shairport Sync Feb 25 17:30:04 volumio4 volumio[1153]: info: Starting Shairport Sync Feb 25 17:30:04 volumio4 sudo[2578]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 sudo[2578]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:04 volumio4 sudo[2596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 17:30:04 volumio4 sudo[2597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 17:30:04 volumio4 sudo[2596]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 sudo[2597]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 17:30:04 volumio4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 25 17:30:04 volumio4 systemd[1]: shairport-sync.service: Succeeded. Feb 25 17:30:04 volumio4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 25 17:30:04 volumio4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 25 17:30:04 volumio4 sudo[2596]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:04 volumio4 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 25 17:30:04 volumio4 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 25 17:30:04 volumio4 systemd[1]: shairport-sync.service: Succeeded. Feb 25 17:30:04 volumio4 volumio[1153]: info: Shairport-Sync Started Feb 25 17:30:04 volumio4 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 25 17:30:04 volumio4 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 25 17:30:04 volumio4 sudo[2597]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:04 volumio4 volumio[1153]: info: Shairport-Sync Started Feb 25 17:30:05 volumio4 mpd[2616]: Feb 25 17:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 25 17:30:05 volumio4 systemd[1]: Started Music Player Daemon. Feb 25 17:30:05 volumio4 sudo[2562]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:05 volumio4 sudo[2541]: pam_unix(sudo:session): session closed for user root Feb 25 17:30:05 volumio4 volumio[1153]: error: MPD error: The expression evaluated to a falsy value: Feb 25 17:30:05 volumio4 volumio[1153]: assert.ok(self.idling) Feb 25 17:30:05 volumio4 volumio[1153]: error: The expression evaluated to a falsy value: Feb 25 17:30:05 volumio4 volumio[1153]: assert.ok(self.idling) Feb 25 17:30:05 volumio4 volumio[1153]: error: updateQueue error: null Feb 25 17:30:07 volumio4 volumio[1153]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 25 17:30:07 volumio4 volumio[1153]: info: CoreStateMachine::getcurrentVolume Feb 25 17:30:07 volumio4 volumio[1153]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 17:30:08 volumio4 volumio[1153]: info: VolumeController:: Volume=100 Mute =false Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:08 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreStateMachine::updateTrackBlock Feb 25 17:30:08 volumio4 volumio[1153]: info: CorePlayQueue::getTrackBlock Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 17:30:08 volumio4 volumio[1153]: info: VolumeController:: Volume=100 Mute =false Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:08 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:08 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPlay Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::play index undefined Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::startPlaybackTimer Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::clearAddPlayTracks USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand stop took 1 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 17:30:11 volumio4 volumio[1153]: info: Feb 25 17:30:11 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:30:11 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand clear took 1 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand add "USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav" Feb 25 17:30:11 volumio4 volumio[1153]: info: Feb 25 17:30:11 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:30:11 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:30:11 volumio4 volumio[1153]: error: updateQueue error: null Feb 25 17:30:11 volumio4 volumio[1153]: info: Feb 25 17:30:11 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:30:11 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:30:11 volumio4 volumio[1153]: info: ------------------------------ 3ms Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand add "USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav" took 3 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: info: ------------------------------ 2ms Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand play Feb 25 17:30:11 volumio4 volumio[1153]: info: Feb 25 17:30:11 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:30:11 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:30:11 volumio4 volumio[1153]: info: Feb 25 17:30:11 volumio4 volumio[1153]: ---------------------------- MPD announces state update: player Feb 25 17:30:11 volumio4 volumio[1153]: info: ------------------------------ 4ms Feb 25 17:30:11 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:11 volumio4 volumio[1153]: info: ------------------------------ 3ms Feb 25 17:30:11 volumio4 volumio[1153]: info: Feb 25 17:30:11 volumio4 volumio[1153]: ---------------------------- MPD announces state update: player Feb 25 17:30:11 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand status took 11 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand status took 10 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand clearerror took 9 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand clearerror took 8 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::parseTrackInfo Feb 25 17:30:11 volumio4 volumio[1153]: verbose: ControllerMpd::parseTrackInfo Feb 25 17:30:11 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(01) [張學友] 吻別.wav","artist":null,"album":null,"uri":"USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav","trackType":"wav"} Feb 25 17:30:11 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:11 volumio4 volumio[1153]: info: No code Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:11 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"(01) [張學友] 吻別.wav","artist":null,"album":null,"uri":"USB/1234-5678/张学友 - 吻别 (MQA-UHQCD) (日本压碟) 2023 [原抓WAV+CUE]/(01) [張學友] 吻別.wav","trackType":"wav"} Feb 25 17:30:11 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:11 volumio4 volumio[1153]: info: No code Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:11 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:11 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:11 volumio4 volumio[1153]: info: ------------------------------ 95ms Feb 25 17:30:11 volumio4 volumio[1153]: info: ------------------------------ 94ms Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:30:14 volumio4 volumio[1153]: info: Retrieving Cloud Streaming UI Feb 25 17:30:14 volumio4 volumio[1153]: info: Getting Tidal Cloud Configuration Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:30:14 volumio4 volumio[1153]: info: Getting Qobuz Cloud Configuration Feb 25 17:30:14 volumio4 volumio[1153]: info: Asking plugin for UI Config Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:30:14 volumio4 volumio[1153]: info: Getting Spotify Cloud Configuration Feb 25 17:30:14 volumio4 volumio[1153]: info: Asking plugin for UI Config Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:30:14 volumio4 volumio[1153]: info: Saving Spotify Acccount Feb 25 17:30:14 volumio4 volumio[1153]: info: Got Tidal Cloud Configuration Feb 25 17:30:14 volumio4 volumio[1153]: info: Got it Feb 25 17:30:14 volumio4 volumio[1153]: info: Got it Feb 25 17:30:14 volumio4 volumio[1153]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 17:30:14 volumio4 volumio[1153]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetBrowseSources Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetBrowseSources Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::volumioGetBrowseSources Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 25 17:30:14 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand update Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand update took 4 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 4 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 3 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 3 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 2 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatetrue Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatetrue Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 17:30:16 volumio4 volumio[1153]: info: MPD Database updated - AlbumList cache refreshed Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces state update: database Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:30:16 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: MPD Database updated - AlbumList cache refreshed Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces state update: database Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces system playlist update Feb 25 17:30:16 volumio4 volumio[1153]: info: Ignoring MPD Status Update Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:16 volumio4 volumio[1153]: error: updateQueue error: null Feb 25 17:30:16 volumio4 volumio[1153]: error: updateQueue error: null Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand playlistinfo took 65 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand playlistinfo took 45 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 9 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 13ms Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 6 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 8ms Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseTrackInfo Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseTrackInfo Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 25 17:30:16 volumio4 volumio[1153]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:16 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: No code Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:16 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: No code Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 200ms Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 198ms Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 122ms Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 118ms Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: Feb 25 17:30:16 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 127 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 123 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 4 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: info: sendMpdCommand status took 3 milliseconds Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatefalse Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatefalse Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:30:16 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:16 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: No code Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:16 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: No code Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:16 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:16 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 288ms Feb 25 17:30:16 volumio4 volumio[1153]: info: ------------------------------ 165ms Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand update Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: info: Feb 25 17:30:18 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand update took 4 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: info: Feb 25 17:30:18 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:18 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: info: Feb 25 17:30:18 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:18 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 6 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 4 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 4 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 3 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:18 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatefalse Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:18 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatefalse Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:18 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:18 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:18 volumio4 volumio[1153]: info: No code Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:18 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:18 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:18 volumio4 volumio[1153]: info: No code Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:18 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:18 volumio4 volumio[1153]: info: ------------------------------ 130ms Feb 25 17:30:18 volumio4 volumio[1153]: info: ------------------------------ 128ms Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: info: Feb 25 17:30:18 volumio4 volumio[1153]: ---------------------------- MPD announces state update: update Feb 25 17:30:18 volumio4 volumio[1153]: info: ControllerMpd::getState Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 130 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 129 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 4 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: info: sendMpdCommand status took 3 milliseconds Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:18 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatefalse Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:18 volumio4 volumio[1153]: info: Command Router : Notfying DB Updatefalse Feb 25 17:30:18 volumio4 volumio[1153]: info: CoreCommandRouter::Close All Modals sent Feb 25 17:30:18 volumio4 volumio[1153]: verbose: ControllerMpd::parseState Feb 25 17:30:19 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:19 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:19 volumio4 volumio[1153]: info: No code Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:19 volumio4 volumio[1153]: info: ControllerMpd::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::servicePushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 25 17:30:19 volumio4 volumio[1153]: verbose: CURRENT POSITION 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::syncState stateService stop Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:19 volumio4 volumio[1153]: info: No code Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreStateMachine::pushState Feb 25 17:30:19 volumio4 volumio[1153]: info: CorePlayQueue::getTrack 0 Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::volumioPushState Feb 25 17:30:19 volumio4 volumio[1153]: info: ------------------------------ 248ms Feb 25 17:30:19 volumio4 volumio[1153]: info: ------------------------------ 122ms Feb 25 17:30:19 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 25 17:30:22 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 25 17:30:22 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 25 17:30:22 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 25 17:30:24 volumio4 volumio[1153]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L 12v2T-2.local. -m SMB3_11 Feb 25 17:30:24 volumio4 volumio[1153]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L FN-EVO2-AC2C.local. -m SMB3_11 Feb 25 17:30:24 volumio4 volumio[1153]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L FN-EVO2-AC2C.local. -m SMB3_11 Feb 25 17:30:24 volumio4 volumio[1153]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L volumio2.local. -m SMB3_11 Feb 25 17:30:26 volumio4 volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 25 17:30:27 volumio4 volumio[1153]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 17:30:28 volumio4 volumio[1153]: Error: dns service error: unknown Feb 25 17:30:28 volumio4 volumio[1153]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Feb 25 17:30:28 volumio4 volumio[1153]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Feb 25 17:30:28 volumio4 volumio[1153]: errorCode: -65537 Feb 25 17:30:28 volumio4 volumio[1153]: } Feb 25 17:30:28 volumio4 volumio[1153]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 17:30:28 volumio4 sudo[2718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-25 17:29 Feb 25 17:30:28 volumio4 sudo[2718]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:55:15 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="2f3686ade78abf3b92c180a0c5b20c6b"