-- Logs begin at Mon 2025-02-17 22:43:03 CST, end at Mon 2025-04-14 21:04:25 CST. -- Apr 14 21:03:06 5jq kernel: usb 1-3.3: new full-speed USB device number 3 using xhci_hcd Apr 14 21:03:06 5jq kernel: usb 1-3.3: New USB device found, idVendor=24ae, idProduct=2015, bcdDevice= 1.02 Apr 14 21:03:06 5jq kernel: usb 1-3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Apr 14 21:03:06 5jq kernel: usb 1-3.3: Product: Rapoo 2.4G Wireless Device Apr 14 21:03:06 5jq kernel: usb 1-3.3: Manufacturer: RAPOO Apr 14 21:03:06 5jq kernel: input: RAPOO Rapoo 2.4G Wireless Device as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.0/0003:24AE:2015.0001/input/input9 Apr 14 21:03:06 5jq kernel: hid-generic 0003:24AE:2015.0001: input,hidraw0: USB HID v1.11 Keyboard [RAPOO Rapoo 2.4G Wireless Device] on usb-0000:00:14.0-3.3/input0 Apr 14 21:03:06 5jq kernel: input: RAPOO Rapoo 2.4G Wireless Device Mouse as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.1/0003:24AE:2015.0002/input/input10 Apr 14 21:03:06 5jq kernel: input: RAPOO Rapoo 2.4G Wireless Device Consumer Control as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.1/0003:24AE:2015.0002/input/input11 Apr 14 21:03:06 5jq kernel: input: RAPOO Rapoo 2.4G Wireless Device System Control as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.1/0003:24AE:2015.0002/input/input12 Apr 14 21:03:06 5jq kernel: hid-generic 0003:24AE:2015.0002: input,hiddev0,hidraw1: USB HID v1.11 Mouse [RAPOO Rapoo 2.4G Wireless Device] on usb-0000:00:14.0-3.3/input1 Apr 14 21:03:06 5jq kernel: usbcore: registered new interface driver usbmouse Apr 14 21:03:06 5jq kernel: usbcore: registered new interface driver usbkbd Apr 14 21:03:06 5jq systemd-udevd[8258]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 14 21:03:06 5jq systemd-udevd[8262]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 14 21:03:06 5jq systemd-logind[781]: Watching system buttons on /dev/input/event12 (RAPOO Rapoo 2.4G Wireless Device System Control) Apr 14 21:03:06 5jq systemd-udevd[8260]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 14 21:03:06 5jq systemd-udevd[8264]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 14 21:03:06 5jq systemd-logind[781]: Watching system buttons on /dev/input/event9 (RAPOO Rapoo 2.4G Wireless Device) Apr 14 21:03:06 5jq systemd-udevd[8261]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 14 21:03:06 5jq systemd-logind[781]: Watching system buttons on /dev/input/event11 (RAPOO Rapoo 2.4G Wireless Device Consumer Control) Apr 14 21:03:12 5jq volumio[1008]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 21:03:12 5jq volumio[1008]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Apr 14 21:03:12 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 21:03:13 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 14 21:03:13 5jq sudo[8303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 14 21:03:13 5jq sudo[8303]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 14 21:03:13 5jq sudo[8309]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8303]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq sudo[8323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 14 21:03:13 5jq sudo[8323]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 14 21:03:13 5jq sudo[8315]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8309]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 14 21:03:13 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 14 21:03:13 5jq sudo[8330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 14 21:03:13 5jq sudo[8330]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8323]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq sudo[8315]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq sudo[8330]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq sudo[8340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 21:03:13 5jq sudo[8340]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 14 21:03:13 5jq sudo[8346]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8340]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq sudo[8346]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq volumio[1008]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 14 21:03:13 5jq volumio[1008]: wlan0 Interface doesn't support scanning. Apr 14 21:03:13 5jq volumio[1008]: info: Cannot use regular scanning, forcing with ap-force Apr 14 21:03:13 5jq sudo[8354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 14 21:03:13 5jq sudo[8354]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:13 5jq sudo[8354]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:13 5jq volumio[1008]: command failed: No such device (-19) Apr 14 21:03:13 5jq volumio[1008]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 14 21:03:13 5jq volumio[1008]: command failed: No such device (-19) Apr 14 21:03:38 5jq sudo[8410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 14 21:03:38 5jq sudo[8410]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:38 5jq sudo[8410]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:38 5jq sudo[8412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 21:03:38 5jq sudo[8412]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:38 5jq sudo[8412]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:38 5jq volumio[1008]: verbose: New Socket.io Connection to 192.168.199.40 from 192.168.199.113 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.3.1 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 Apr 14 21:03:38 5jq volumio[1008]: info: CoreCommandRouter::volumioGetVisibleSources Apr 14 21:03:38 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 21:03:38 5jq volumio[1008]: info: CoreCommandRouter::volumioGetState Apr 14 21:03:38 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:38 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 14 21:03:38 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 21:03:38 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 21:03:38 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 14 21:03:38 5jq sudo[8418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 14 21:03:38 5jq sudo[8418]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:38 5jq sudo[8418]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:38 5jq sudo[8420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 21:03:38 5jq sudo[8420]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:03:39 5jq sudo[8420]: pam_unix(sudo:session): session closed for user root Apr 14 21:03:39 5jq volumio[1008]: verbose: New Socket.io Connection to 192.168.199.40 from 192.168.199.113 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.3.1 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 Apr 14 21:03:39 5jq volumio[1008]: info: CoreCommandRouter::volumioGetState Apr 14 21:03:39 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:39 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 14 21:03:39 5jq volumio[1008]: info: Listing playlists Apr 14 21:03:39 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 14 21:03:39 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 21:03:39 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 21:03:39 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 14 21:03:40 5jq volumio[1008]: info: CoreCommandRouter::volumioPlay Apr 14 21:03:40 5jq volumio[1008]: info: CoreStateMachine::play index undefined Apr 14 21:03:40 5jq volumio[1008]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 21:03:40 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:40 5jq volumio[1008]: info: CoreStateMachine::startPlaybackTimer Apr 14 21:03:40 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::clearAddPlayTracks NAS/nas/38.6_音频.mp3 Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand stop took 3 milliseconds Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand clear took 0 milliseconds Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand add "NAS/nas/38.6_音频.mp3" Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces system playlist update Apr 14 21:03:40 5jq volumio[1008]: info: Ignoring MPD Status Update Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand add "NAS/nas/38.6_音频.mp3" took 3 milliseconds Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand play Apr 14 21:03:40 5jq volumio[1008]: Upnp client error: Error: This socket has been ended by the other party Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces system playlist update Apr 14 21:03:40 5jq volumio[1008]: info: Ignoring MPD Status Update Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces system playlist update Apr 14 21:03:40 5jq volumio[1008]: info: Ignoring MPD Status Update Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces system playlist update Apr 14 21:03:40 5jq volumio[1008]: info: Ignoring MPD Status Update Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces state update: player Apr 14 21:03:40 5jq volumio[1008]: info: ------------------------------ 15ms Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand play took 11 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:03:40 5jq volumio[1008]: info: ------------------------------ 8ms Apr 14 21:03:40 5jq volumio[1008]: info: ------------------------------ 7ms Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces system playlist update Apr 14 21:03:40 5jq volumio[1008]: info: Ignoring MPD Status Update Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces state update: player Apr 14 21:03:40 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces system playlist update Apr 14 21:03:40 5jq volumio[1008]: info: Ignoring MPD Status Update Apr 14 21:03:40 5jq volumio[1008]: info: Apr 14 21:03:40 5jq volumio[1008]: ---------------------------- MPD announces state update: player Apr 14 21:03:40 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:03:40 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 14 21:03:40 5jq volumio[1008]: info: Received Get System Info Apr 14 21:03:40 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 21:03:40 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 21:03:40 5jq volumio[1008]: info: Discovery: Getting this device information Apr 14 21:03:40 5jq volumio[1008]: info: CoreCommandRouter::volumioGetState Apr 14 21:03:40 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:40 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 21:03:40 5jq volumio[1008]: info: ------------------------------ 23ms Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand status took 26 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: ------------------------------ 24ms Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand status took 24 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: ------------------------------ 24ms Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand clearerror Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand status took 23 milliseconds Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand clearerror took 18 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand clearerror took 16 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand clearerror took 15 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 14 21:03:40 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:03:40 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:03:40 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:03:40 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:03:40 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:40 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: 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":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:03:41 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: No code Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: 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":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:03:41 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: No code Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: 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":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:03:41 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: No code Apr 14 21:03:41 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:03:41 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:03:41 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:03:41 5jq volumio[1008]: info: ------------------------------ 170ms Apr 14 21:03:41 5jq volumio[1008]: info: ------------------------------ 167ms Apr 14 21:03:41 5jq volumio[1008]: info: ------------------------------ 166ms Apr 14 21:03:49 5jq volumio[1008]: info: CoreCommandRouter::volumioGetVisibleSources Apr 14 21:03:49 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 21:03:49 5jq volumio[1008]: info: CoreCommandRouter::volumioGetQueue Apr 14 21:03:49 5jq volumio[1008]: info: CoreStateMachine::getQueue Apr 14 21:03:49 5jq volumio[1008]: info: CorePlayQueue::getQueue Apr 14 21:03:51 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 21:03:51 5jq volumio[1008]: info: CURURI: music-library Apr 14 21:03:51 5jq volumio[1008]: info: Preload queue cleared Apr 14 21:04:13 5jq kernel: usb 1-3.4: new high-speed USB device number 4 using xhci_hcd Apr 14 21:04:13 5jq kernel: usb 1-3.4: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.00 Apr 14 21:04:13 5jq kernel: usb 1-3.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 14 21:04:13 5jq kernel: usb 1-3.4: Product: SanDisk 3.2Gen1 Apr 14 21:04:13 5jq kernel: usb 1-3.4: Manufacturer: USB Apr 14 21:04:13 5jq kernel: usb 1-3.4: SerialNumber: 0401f7c65f62c368f1b3a97d896eb9aa707b3752f69c40668c727f179fdeb9ac94ba000000000000000000009d44a4baff12071867558107baa8ceb6 Apr 14 21:04:13 5jq kernel: usb-storage 1-3.4:1.0: USB Mass Storage device detected Apr 14 21:04:13 5jq kernel: scsi host0: usb-storage 1-3.4:1.0 Apr 14 21:04:14 5jq kernel: scsi 0:0:0:0: Direct-Access USB SanDisk 3.2Gen1 1.00 PQ: 0 ANSI: 6 Apr 14 21:04:14 5jq kernel: sd 0:0:0:0: [sda] 120176640 512-byte logical blocks: (61.5 GB/57.3 GiB) Apr 14 21:04:14 5jq kernel: sd 0:0:0:0: [sda] Write Protect is off Apr 14 21:04:14 5jq kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 Apr 14 21:04:14 5jq kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Apr 14 21:04:14 5jq kernel: sda: sda1 sda2 Apr 14 21:04:14 5jq kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Apr 14 21:04:14 5jq kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Apr 14 21:04:15 5jq volumio[1008]: info: Mounting Device 老毛桃U盘 Apr 14 21:04:15 5jq sudo[8537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/老毛桃U盘 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 14 21:04:15 5jq sudo[8537]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:04:15 5jq ntfs-3g[8540]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 14 21:04:15 5jq ntfs-3g[8540]: Mounted /dev/sda1 (Read-Write, label "老毛桃U盘", NTFS 3.1) Apr 14 21:04:15 5jq ntfs-3g[8540]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 14 21:04:15 5jq ntfs-3g[8540]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Apr 14 21:04:15 5jq ntfs-3g[8540]: Global ownership and permissions enforced, configuration type 7 Apr 14 21:04:15 5jq sudo[8537]: pam_unix(sudo:session): session closed for user root Apr 14 21:04:15 5jq volumio[1008]: info: Mounting Device EFI Apr 14 21:04:15 5jq sudo[8547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 14 21:04:15 5jq sudo[8547]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 21:04:15 5jq kernel: FAT-fs (sda2): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Apr 14 21:04:15 5jq sudo[8547]: pam_unix(sudo:session): session closed for user root Apr 14 21:04:15 5jq volumio[1008]: info: Scanning new location : "USB/老毛桃U盘" Apr 14 21:04:16 5jq volumio[1008]: info: Scanning new location : "USB/EFI" Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:16 5jq volumio[1008]: info: Apr 14 21:04:16 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:16 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:16 5jq volumio[1008]: info: Apr 14 21:04:16 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:16 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:16 5jq volumio[1008]: info: Apr 14 21:04:16 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:16 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand status took 9 milliseconds Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand status took 7 milliseconds Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand status took 7 milliseconds Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand status took 6 milliseconds Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand status took 5 milliseconds Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand status took 4 milliseconds Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:16 5jq volumio[1008]: info: Command Router : Notfying DB Updatetrue Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:16 5jq volumio[1008]: info: Command Router : Notfying DB Updatetrue Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:16 5jq volumio[1008]: info: Command Router : Notfying DB Updatetrue Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 71 milliseconds Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 46 milliseconds Apr 14 21:04:16 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:04:16 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:04:16 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:16 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: No code Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:16 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: No code Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:16 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: No code Apr 14 21:04:16 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:16 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:16 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:16 5jq volumio[1008]: info: ------------------------------ 214ms Apr 14 21:04:16 5jq volumio[1008]: info: ------------------------------ 213ms Apr 14 21:04:16 5jq volumio[1008]: info: ------------------------------ 212ms Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: Apr 14 21:04:18 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:18 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: Apr 14 21:04:18 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:18 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: Apr 14 21:04:18 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:18 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 8 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 8 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 6 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 5 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 5 milliseconds Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:18 5jq volumio[1008]: info: Command Router : Notfying DB Updatetrue Apr 14 21:04:18 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:18 5jq volumio[1008]: info: Command Router : Notfying DB Updatetrue Apr 14 21:04:18 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:18 5jq volumio[1008]: info: Command Router : Notfying DB Updatetrue Apr 14 21:04:18 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: Apr 14 21:04:18 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 142 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: Apr 14 21:04:18 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:18 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: Apr 14 21:04:18 5jq volumio[1008]: ---------------------------- MPD announces state update: update Apr 14 21:04:18 5jq volumio[1008]: info: ControllerMpd::getState Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand status Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 90 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 63 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 19 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 19 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 19 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 19 milliseconds Apr 14 21:04:18 5jq volumio[1008]: info: sendMpdCommand status took 16 milliseconds Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:04:18 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:19 5jq volumio[1008]: info: Command Router : Notfying DB Updatefalse Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:19 5jq volumio[1008]: info: Command Router : Notfying DB Updatefalse Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:19 5jq volumio[1008]: info: Command Router : Notfying DB Updatefalse Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::Close All Modals sent Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::parseState Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 21:04:19 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:19 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: No code Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:19 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: No code Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:19 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: No code Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: ------------------------------ 404ms Apr 14 21:04:19 5jq volumio[1008]: info: ------------------------------ 404ms Apr 14 21:04:19 5jq volumio[1008]: info: ------------------------------ 432ms Apr 14 21:04:19 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 214 milliseconds Apr 14 21:04:19 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 186 milliseconds Apr 14 21:04:19 5jq volumio[1008]: info: sendMpdCommand playlistinfo took 154 milliseconds Apr 14 21:04:19 5jq volumio[1008]: verbose: ControllerMpd::parseTrackInfo Apr 14 21:04:19 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: 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":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:19 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: No code Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: 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":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:19 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: No code Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: ControllerMpd::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::servicePushState Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: 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":"38.6_音频.mp3","artist":null,"album":null,"uri":"NAS/nas/38.6_音频.mp3","trackType":"mp3"} Apr 14 21:04:19 5jq volumio[1008]: verbose: CURRENT POSITION 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState stateService stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::syncState currentStatus stop Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: No code Apr 14 21:04:19 5jq volumio[1008]: info: CoreStateMachine::pushState Apr 14 21:04:19 5jq volumio[1008]: info: CorePlayQueue::getTrack 0 Apr 14 21:04:19 5jq volumio[1008]: info: CoreCommandRouter::volumioPushState Apr 14 21:04:19 5jq volumio[1008]: info: ------------------------------ 412ms Apr 14 21:04:19 5jq volumio[1008]: info: ------------------------------ 409ms Apr 14 21:04:19 5jq volumio[1008]: info: ------------------------------ 408ms Apr 14 21:04:25 5jq volumio[1008]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 21:04:25 5jq volumio[1008]: Error: connect ECONNREFUSED 162.220.12.226:80 Apr 14 21:04:25 5jq volumio[1008]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 14 21:04:25 5jq volumio[1008]: errno: -111, Apr 14 21:04:25 5jq volumio[1008]: code: 'ECONNREFUSED', Apr 14 21:04:25 5jq volumio[1008]: syscall: 'connect', Apr 14 21:04:25 5jq volumio[1008]: address: '162.220.12.226', Apr 14 21:04:25 5jq volumio[1008]: port: 80 Apr 14 21:04:25 5jq volumio[1008]: } Apr 14 21:04:25 5jq volumio[1008]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 21:04:25 5jq sudo[8601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-14 21:03 Apr 14 21:04:25 5jq sudo[8601]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"