-- Logs begin at Thu 2019-02-14 10:12:07 UTC, end at Wed 2025-06-18 12:45:28 UTC. -- Jun 18 12:44:02 volumio volumio[1187]: info: VolumeController::SetAlsaVolume100 Jun 18 12:44:02 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:44:02 volumio volumio[1187]: info: CorePlayQueue::getTrack 0 Jun 18 12:44:02 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:44:02 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:44:07 volumio volumio[1187]: info: VolumeController::SetAlsaVolume82 Jun 18 12:44:07 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:44:07 volumio volumio[1187]: info: CorePlayQueue::getTrack 0 Jun 18 12:44:07 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:44:07 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:44:11 volumio volumio[1187]: info: CoreCommandRouter::volumioGetState Jun 18 12:44:11 volumio volumio[1187]: info: CorePlayQueue::getTrack 0 Jun 18 12:44:13 volumio volumio[1187]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 18 12:44:13 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 18 12:44:13 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jun 18 12:44:13 volumio sudo[6206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jun 18 12:44:13 volumio sudo[6206]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:44:13 volumio sudo[6211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 18 12:44:13 volumio sudo[6211]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:44:13 volumio sudo[6206]: pam_unix(sudo:session): session closed for user root Jun 18 12:44:13 volumio sudo[6211]: pam_unix(sudo:session): session closed for user root Jun 18 12:44:13 volumio sudo[6219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 18 12:44:13 volumio sudo[6219]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:44:13 volumio sudo[6219]: pam_unix(sudo:session): session closed for user root Jun 18 12:44:13 volumio sudo[6226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 18 12:44:13 volumio sudo[6226]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:44:13 volumio sudo[6226]: pam_unix(sudo:session): session closed for user root Jun 18 12:44:13 volumio sudo[6232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 18 12:44:13 volumio sudo[6232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:44:13 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 18 12:44:13 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 18 12:44:13 volumio sudo[6232]: pam_unix(sudo:session): session closed for user root Jun 18 12:44:13 volumio sudo[6235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 18 12:44:13 volumio sudo[6235]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:44:13 volumio sudo[6235]: pam_unix(sudo:session): session closed for user root Jun 18 12:44:13 volumio sudo[6238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 18 12:44:13 volumio sudo[6238]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:44:15 volumio sudo[6238]: pam_unix(sudo:session): session closed for user root Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419359, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:22 volumio nmbd[990]: Packet send failed to 192.168.0.255(138) ERRNO=Network is unreachable Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419499, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:22 volumio nmbd[990]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419554, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:22 volumio nmbd[990]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419590, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 18 12:44:22 volumio nmbd[990]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419630, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:22 volumio nmbd[990]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419662, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 18 12:44:22 volumio nmbd[990]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419696, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:22 volumio nmbd[990]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419728, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 18 12:44:22 volumio nmbd[990]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419762, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:22 volumio nmbd[990]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419796, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 18 12:44:22 volumio nmbd[990]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419829, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:22 volumio nmbd[990]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jun 18 12:44:22 volumio nmbd[990]: [2025/06/18 12:44:22.419861, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jun 18 12:44:22 volumio nmbd[990]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jun 18 12:44:27 volumio nmbd[990]: [2025/06/18 12:44:27.514594, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 18 12:44:27 volumio nmbd[990]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Jun 18 12:45:10 volumio volumio[1187]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Jun 18 12:45:10 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Jun 18 12:45:16 volumio volumio[1187]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Jun 18 12:45:16 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Jun 18 12:45:19 volumio volumio[1187]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Jun 18 12:45:19 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Jun 18 12:45:19 volumio sudo[6386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Jun 18 12:45:19 volumio sudo[6386]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:19 volumio sudo[6386]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:19 volumio sudo[6388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Jun 18 12:45:19 volumio sudo[6388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:19 volumio sudo[6388]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:19 volumio volumio[1187]: info: Permissions for /etc/network/interfaces set Jun 18 12:45:19 volumio volumio[1187]: info: Restarting Wireless Network Jun 18 12:45:19 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jun 18 12:45:19 volumio volumio[1187]: info: Discovery: Restarting Advertising due to device name change Jun 18 12:45:19 volumio sudo[6391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jun 18 12:45:19 volumio sudo[6391]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:19 volumio systemd[1]: Stopping Wireless Services... Jun 18 12:45:19 volumio kernel: wlan0: deauthenticating from 64:64:4a:a7:b3:43 by local choice (Reason: 3=DEAUTH_LEAVING) Jun 18 12:45:19 volumio dhcpcd[945]: wlan0: carrier lost Jun 18 12:45:19 volumio avahi-daemon[869]: Withdrawing address record for 192.168.0.212 on wlan0. Jun 18 12:45:19 volumio avahi-daemon[869]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.212. Jun 18 12:45:19 volumio wpa_supplicant[5389]: wlan0: CTRL-EVENT-DISCONNECTED bssid=64:64:4a:a7:b3:43 reason=3 locally_generated=1 Jun 18 12:45:19 volumio avahi-daemon[869]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 18 12:45:19 volumio volumio[1187]: info: Discovery: A device disappeared from network Jun 18 12:45:19 volumio volumio[1187]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jun 18 12:45:19 volumio dhcpcd[945]: wlan0: deleting route to 192.168.0.0/24 Jun 18 12:45:19 volumio dhcpcd[945]: wlan0: deleting default route via 192.168.0.1 Jun 18 12:45:19 volumio wpa_supplicant[5389]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 18 12:45:19 volumio wpa_supplicant[5389]: wlan0: CTRL-EVENT-TERMINATING Jun 18 12:45:19 volumio systemd[1]: wireless.service: Succeeded. Jun 18 12:45:19 volumio systemd[1]: Stopped Wireless Services. Jun 18 12:45:19 volumio systemd[1]: Starting Wireless Services... Jun 18 12:45:19 volumio wireless.js[6420]: Cleaning previous... Jun 18 12:45:19 volumio sudo[6435]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 18 12:45:19 volumio sudo[6435]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:19 volumio sudo[6435]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:19 volumio sudo[6437]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 18 12:45:19 volumio sudo[6437]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:19 volumio sudo[6437]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:19 volumio wireless.js[6420]: Stopped aP Jun 18 12:45:19 volumio sudo[6444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 18 12:45:19 volumio sudo[6444]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:20 volumio sudo[6444]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:20 volumio sudo[6447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 18 12:45:20 volumio sudo[6447]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:20 volumio sudo[6447]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:20 volumio sudo[6454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 18 12:45:20 volumio sudo[6454]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:20 volumio sudo[6454]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:20 volumio sudo[6456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 18 12:45:20 volumio sudo[6456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:20 volumio sudo[6456]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:21 volumio wireless.js[6420]: SETTING APPROPRIATE REG DOMAIN: CN Jun 18 12:45:21 volumio sudo[6461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 18 12:45:21 volumio sudo[6461]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:21 volumio sudo[6461]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:21 volumio sudo[6463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN Jun 18 12:45:21 volumio sudo[6463]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:21 volumio sudo[6463]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:21 volumio wireless.js[6420]: SUCCESSFULLY SET NEW REGDOMAIN: CN Jun 18 12:45:21 volumio wireless.js[6420]: Start wireless flow Jun 18 12:45:21 volumio wireless.js[6420]: Stopped hotspot (if there).. Jun 18 12:45:21 volumio sudo[6468]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 18 12:45:21 volumio sudo[6468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:21 volumio sudo[6468]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:21 volumio sudo[6470]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 18 12:45:21 volumio sudo[6470]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:21 volumio sudo[6470]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:21 volumio wireless.js[6420]: DHCP IP Jun 18 12:45:21 volumio wireless.js[6420]: Start ap Jun 18 12:45:21 volumio wpa_supplicant[6472]: Successfully initialized wpa_supplicant Jun 18 12:45:21 volumio sudo[6473]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jun 18 12:45:21 volumio sudo[6473]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:21 volumio dhcpcd[6475]: sending commands to master dhcpcd process Jun 18 12:45:21 volumio dhcpcd[945]: control command: /sbin/dhcpcd Jun 18 12:45:21 volumio sudo[6473]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:21 volumio volumio[1187]: info: Volumio Network Manager: Network status updated: 0 Jun 18 12:45:22 volumio wireless.js[6420]: trying... Jun 18 12:45:22 volumio sudo[6492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 18 12:45:22 volumio sudo[6492]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:22 volumio sudo[6492]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:22 volumio wpa_supplicant[6476]: wlan0: SME: Trying to authenticate with 64:64:4a:a7:b3:43 (SSID='Xiaomi_HDZZ' freq=2412 MHz) Jun 18 12:45:22 volumio kernel: wlan0: authenticate with 64:64:4a:a7:b3:43 Jun 18 12:45:22 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Jun 18 12:45:22 volumio kernel: wlan0: send auth to 64:64:4a:a7:b3:43 (try 1/3) Jun 18 12:45:22 volumio wpa_supplicant[6476]: wlan0: Trying to associate with 64:64:4a:a7:b3:43 (SSID='Xiaomi_HDZZ' freq=2412 MHz) Jun 18 12:45:22 volumio kernel: wlan0: authenticated Jun 18 12:45:22 volumio kernel: wlan0: associate with 64:64:4a:a7:b3:43 (try 1/3) Jun 18 12:45:22 volumio kernel: wlan0: RX AssocResp from 64:64:4a:a7:b3:43 (capab=0x431 status=0 aid=5) Jun 18 12:45:22 volumio wpa_supplicant[6476]: wlan0: Associated with 64:64:4a:a7:b3:43 Jun 18 12:45:22 volumio wpa_supplicant[6476]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 18 12:45:22 volumio wpa_supplicant[6476]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Jun 18 12:45:22 volumio kernel: wlan0: associated Jun 18 12:45:22 volumio kernel: ath: EEPROM regdomain: 0x809c Jun 18 12:45:22 volumio kernel: ath: EEPROM indicates we should expect a country code Jun 18 12:45:22 volumio kernel: ath: doing EEPROM country->regdmn map search Jun 18 12:45:22 volumio kernel: ath: country maps to regdmn code: 0x52 Jun 18 12:45:22 volumio kernel: ath: Country alpha2 being used: CN Jun 18 12:45:22 volumio kernel: ath: Regpair used: 0x52 Jun 18 12:45:22 volumio kernel: ath: regdomain 0x809c dynamically updated by country element Jun 18 12:45:22 volumio wpa_supplicant[6476]: wlan0: WPA: Key negotiation completed with 64:64:4a:a7:b3:43 [PTK=CCMP GTK=TKIP] Jun 18 12:45:22 volumio wpa_supplicant[6476]: wlan0: CTRL-EVENT-CONNECTED - Connection to 64:64:4a:a7:b3:43 completed [id=0 id_str=] Jun 18 12:45:22 volumio dhcpcd[945]: wlan0: carrier acquired Jun 18 12:45:22 volumio dhcpcd[945]: wlan0: confile file changed, expiring leases Jun 18 12:45:22 volumio dhcpcd[945]: wlan0: IAID 3f:91:6d:35 Jun 18 12:45:22 volumio dhcpcd[945]: wlan0: probing address 192.168.0.212/24 Jun 18 12:45:22 volumio dhcpcd[945]: wlan0: soliciting an IPv6 router Jun 18 12:45:23 volumio wireless.js[6420]: trying... Jun 18 12:45:23 volumio sudo[6497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 18 12:45:23 volumio sudo[6497]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:23 volumio sudo[6497]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioNext Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::next Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::stop Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::stPlaybackTimer Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 0 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::serviceStop Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 0 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::serviceStop Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::stop Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand stop took 3 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::play index undefined Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::startPlaybackTimer Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::clearAddPlayTracks USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3 Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand status took 3 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand stop took 2 milliseconds Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand clear Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:23 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand clear took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3" Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: 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":"10点莉 - 活着 (中文版).mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/10点莉 - 活着 (中文版).mp3","trackType":"mp3"} Jun 18 12:45:23 volumio volumio[1187]: verbose: CURRENT POSITION 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState stateService stop Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: No code Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 18 12:45:23 volumio volumio[1187]: verbose: CURRENT POSITION 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState stateService stop Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: No code Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 18ms Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 15ms Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:23 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:23 volumio volumio[1187]: error: updateQueue error: null Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:23 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 15ms Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3" took 14 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 1ms Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand play Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:23 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 4ms Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand play took 4 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 3ms Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:23 volumio volumio[1187]: info: Jun 18 12:45:23 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AZ珍珍 - 放不下想又怕.mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3","trackType":"mp3"} Jun 18 12:45:23 volumio volumio[1187]: verbose: CURRENT POSITION 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AZ珍珍 - 放不下想又怕.mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3","trackType":"mp3"} Jun 18 12:45:23 volumio volumio[1187]: verbose: CURRENT POSITION 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:23 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AZ珍珍 - 放不下想又怕.mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3","trackType":"mp3"} Jun 18 12:45:23 volumio volumio[1187]: verbose: CURRENT POSITION 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:23 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 11ms Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 14ms Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 13ms Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand status took 11 milliseconds Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:23 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:23 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:23 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"AZ珍珍 - 放不下想又怕.mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3","trackType":"mp3"} Jun 18 12:45:23 volumio volumio[1187]: verbose: CURRENT POSITION 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:23 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:23 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:23 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:23 volumio volumio[1187]: info: ------------------------------ 20ms Jun 18 12:45:24 volumio wireless.js[6420]: trying... Jun 18 12:45:24 volumio sudo[6500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 18 12:45:24 volumio sudo[6500]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:24 volumio sudo[6500]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:24 volumio ntpd[5467]: Deleting interface #4 wlan0, 192.168.0.212#123, interface stats: received=108, sent=122, dropped=0, active_time=287 secs Jun 18 12:45:24 volumio ntpd[5467]: 193.182.111.12 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 162.159.200.1 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 116.203.151.74 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 119.28.206.193 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 95.111.202.5 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 108.59.2.24 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 211.68.71.26 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 193.182.111.141 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 162.159.200.123 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 84.16.67.12 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 193.182.111.142 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 45.76.221.157 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 193.182.111.143 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 176.126.78.152 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 202.118.1.81 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio ntpd[5467]: 111.230.189.174 local addr 192.168.0.212 -> Jun 18 12:45:24 volumio volumio[1187]: info: Discovery: Started advertising with name: Volumio Jun 18 12:45:25 volumio wireless.js[6420]: trying... Jun 18 12:45:25 volumio sudo[6504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 18 12:45:25 volumio sudo[6504]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:25 volumio sudo[6504]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioNext Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::next Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::stop Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::stPlaybackTimer Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::serviceStop Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 1 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::serviceStop Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::stop Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand stop took 2 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::play index undefined Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::startPlaybackTimer Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::clearAddPlayTracks USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3 Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand status took 2 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand stop took 2 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand status took 0 milliseconds Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand clear Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:25 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand clear took 1 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3" Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: 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":"AZ珍珍 - 放不下想又怕.mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/AZ珍珍 - 放不下想又怕.mp3","trackType":"mp3"} Jun 18 12:45:25 volumio volumio[1187]: verbose: CURRENT POSITION 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState stateService stop Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: No code Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 12ms Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 9ms Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:25 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:25 volumio volumio[1187]: error: updateQueue error: null Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:25 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 9ms Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3" took 9 milliseconds Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand play Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:25 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 5ms Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 6ms Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand play took 5 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 5ms Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:25 volumio volumio[1187]: info: Jun 18 12:45:25 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand status took 3 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand status took 3 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand status took 3 milliseconds Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand status took 2 milliseconds Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 18 12:45:25 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:25 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G","artist":"DJ小鱼儿","album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3","trackType":"mp3"} Jun 18 12:45:25 volumio volumio[1187]: verbose: CURRENT POSITION 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G","artist":"DJ小鱼儿","album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3","trackType":"mp3"} Jun 18 12:45:25 volumio volumio[1187]: verbose: CURRENT POSITION 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:25 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G","artist":"DJ小鱼儿","album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3","trackType":"mp3"} Jun 18 12:45:25 volumio volumio[1187]: verbose: CURRENT POSITION 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:25 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G","artist":"DJ小鱼儿","album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3","trackType":"mp3"} Jun 18 12:45:25 volumio volumio[1187]: verbose: CURRENT POSITION 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:25 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:25 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:25 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 21ms Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 26ms Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 24ms Jun 18 12:45:25 volumio volumio[1187]: info: ------------------------------ 23ms Jun 18 12:45:26 volumio wireless.js[6420]: trying... Jun 18 12:45:26 volumio sudo[6507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 18 12:45:26 volumio sudo[6507]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:26 volumio sudo[6507]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioNext Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::next Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::stop Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::stPlaybackTimer Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::serviceStop Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 2 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::serviceStop Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::stop Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand stop took 3 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::play index undefined Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::startPlaybackTimer Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::clearAddPlayTracks USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3 Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand status took 3 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand stop took 2 milliseconds Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand clear Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:26 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand clear took 1 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3" Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: 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":"G","artist":"DJ小鱼儿","album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/DJ小鱼儿 - 一生回味一面.mp3","trackType":"mp3"} Jun 18 12:45:26 volumio volumio[1187]: verbose: CURRENT POSITION 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState stateService stop Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: No code Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 18 12:45:26 volumio volumio[1187]: verbose: CURRENT POSITION 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState stateService stop Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: No code Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 16ms Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 13ms Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:26 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:26 volumio volumio[1187]: error: updateQueue error: null Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:26 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 13ms Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3" took 12 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 1ms Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand play Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:26 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 5ms Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand play took 5 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 4ms Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand status took 0 milliseconds Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:26 volumio volumio[1187]: info: Jun 18 12:45:26 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"句号","artist":"G.E.M. 邓紫棋","album":"句号","uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3","trackType":"mp3"} Jun 18 12:45:26 volumio volumio[1187]: verbose: CURRENT POSITION 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"句号","artist":"G.E.M. 邓紫棋","album":"句号","uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3","trackType":"mp3"} Jun 18 12:45:26 volumio volumio[1187]: verbose: CURRENT POSITION 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:26 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"句号","artist":"G.E.M. 邓紫棋","album":"句号","uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3","trackType":"mp3"} Jun 18 12:45:26 volumio volumio[1187]: verbose: CURRENT POSITION 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:26 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 10ms Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 14ms Jun 18 12:45:26 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 18 12:45:26 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:26 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"句号","artist":"G.E.M. 邓紫棋","album":"句号","uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3","trackType":"mp3"} Jun 18 12:45:26 volumio volumio[1187]: verbose: CURRENT POSITION 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:26 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:26 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:26 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:26 volumio volumio[1187]: info: ------------------------------ 21ms Jun 18 12:45:27 volumio wireless.js[6420]: trying... Jun 18 12:45:27 volumio sudo[6515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 18 12:45:27 volumio sudo[6515]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 18 12:45:27 volumio sudo[6515]: pam_unix(sudo:session): session closed for user root Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioNext Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::next Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::stop Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::stPlaybackTimer Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::serviceStop Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 3 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::serviceStop Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::stop Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand stop took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::play index undefined Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::startPlaybackTimer Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::clearAddPlayTracks USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3 Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand stop Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::updateTrackBlock Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrackBlock Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand stop took 0 milliseconds Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand clear Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:27 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand clear took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand status took 0 milliseconds Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3" Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: 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":"句号","artist":"G.E.M. 邓紫棋","album":"句号","uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 句号.mp3","trackType":"mp3"} Jun 18 12:45:27 volumio volumio[1187]: verbose: CURRENT POSITION 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState stateService stop Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: No code Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 18 12:45:27 volumio volumio[1187]: verbose: CURRENT POSITION 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState stateService stop Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: No code Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 14ms Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 11ms Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:27 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:27 volumio volumio[1187]: error: updateQueue error: null Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:27 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 12ms Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand add "USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3" took 11 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 1ms Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand play Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces system playlist update Jun 18 12:45:27 volumio volumio[1187]: info: Ignoring MPD Status Update Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 4ms Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand play took 4 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 3ms Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand status took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand status took 0 milliseconds Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:27 volumio volumio[1187]: info: Jun 18 12:45:27 volumio volumio[1187]: ---------------------------- MPD announces state update: player Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::getState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","trackType":"mp3"} Jun 18 12:45:27 volumio volumio[1187]: verbose: CURRENT POSITION 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","trackType":"mp3"} Jun 18 12:45:27 volumio volumio[1187]: verbose: CURRENT POSITION 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:27 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","trackType":"mp3"} Jun 18 12:45:27 volumio volumio[1187]: verbose: CURRENT POSITION 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:27 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 9ms Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 14ms Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 13ms Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand status took 10 milliseconds Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseState Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 18 12:45:27 volumio volumio[1187]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 18 12:45:27 volumio volumio[1187]: verbose: ControllerMpd::parseTrackInfo Jun 18 12:45:27 volumio volumio[1187]: info: ControllerMpd::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::servicePushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":169,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","artist":null,"album":null,"uri":"USB/AUTON/001.主图热门歌曲（更新中）/G.E.M.邓紫棋 - 画 (Live Piano Session II).mp3","trackType":"mp3"} Jun 18 12:45:27 volumio volumio[1187]: verbose: CURRENT POSITION 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState stateService play Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::syncState currentStatus play Jun 18 12:45:27 volumio volumio[1187]: info: Received an update from plugin. extracting info from payload Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: CoreStateMachine::pushState Jun 18 12:45:27 volumio volumio[1187]: info: CorePlayQueue::getTrack 4 Jun 18 12:45:27 volumio volumio[1187]: info: CoreCommandRouter::volumioPushState Jun 18 12:45:27 volumio volumio[1187]: info: ------------------------------ 19ms Jun 18 12:45:27 volumio dhcpcd[945]: wlan0: using static address 192.168.0.212/24 Jun 18 12:45:27 volumio avahi-daemon[869]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.212. Jun 18 12:45:27 volumio avahi-daemon[869]: New relevant interface wlan0.IPv4 for mDNS. Jun 18 12:45:27 volumio dhcpcd[945]: wlan0: adding route to 192.168.0.0/24 Jun 18 12:45:27 volumio avahi-daemon[869]: Registering new address record for 192.168.0.212 on wlan0.IPv4. Jun 18 12:45:27 volumio dhcpcd[945]: wlan0: adding default route via 192.168.0.1 Jun 18 12:45:27 volumio volumio[1187]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 18 12:45:27 volumio volumio[1187]: Error: connect ETIMEDOUT 199.16.156.75:80 Jun 18 12:45:27 volumio volumio[1187]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 18 12:45:27 volumio volumio[1187]: errno: -110, Jun 18 12:45:27 volumio volumio[1187]: code: 'ETIMEDOUT', Jun 18 12:45:27 volumio volumio[1187]: syscall: 'connect', Jun 18 12:45:27 volumio volumio[1187]: address: '199.16.156.75', Jun 18 12:45:27 volumio volumio[1187]: port: 80 Jun 18 12:45:27 volumio volumio[1187]: } Jun 18 12:45:27 volumio volumio[1187]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 18 12:45:28 volumio sudo[6549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-18 12:44 Jun 18 12:45:28 volumio sudo[6549]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 12:21:23 PM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"