-- Logs begin at Tue 2024-10-08 13:20:29 UTC, end at Tue 2024-10-08 13:26:59 UTC. -- Oct 08 13:26:09 volumio kernel: usb 6-1: USB disconnect, device number 2 Oct 08 13:26:09 volumio volumio[863]: info: Oct 08 13:26:09 volumio volumio[863]: ---------------------------- MPD announces state update: player Oct 08 13:26:09 volumio volumio[863]: info: ControllerMpd::getState Oct 08 13:26:09 volumio volumio[863]: info: ControllerMpd::sendMpdCommand status Oct 08 13:26:09 volumio volumio[863]: info: sending command... Oct 08 13:26:09 volumio volumio[863]: info: parsing response... Oct 08 13:26:09 volumio volumio[863]: info: ControllerMpd::sendMpdCommand clearerror Oct 08 13:26:09 volumio volumio[863]: info: sending command... Oct 08 13:26:09 volumio volumio[863]: info: ControllerMpd::parseState Oct 08 13:26:09 volumio volumio[863]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 08 13:26:09 volumio volumio[863]: info: sending command... Oct 08 13:26:09 volumio volumio[863]: info: parsing response... Oct 08 13:26:09 volumio volumio[863]: info: parsing response... Oct 08 13:26:09 volumio volumio[863]: info: ControllerMpd::parseTrackInfo Oct 08 13:26:09 volumio volumio[863]: info: ControllerMpd::pushState Oct 08 13:26:09 volumio volumio[863]: info: CoreCommandRouter::servicePushState Oct 08 13:26:09 volumio volumio[863]: info: CoreStateMachine::syncState Oct 08 13:26:09 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:09 volumio volumio[863]: info: STATE SERVICE {"status":"pause","position":0,"seek":81711,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"0 Kbps","isStreaming":false,"title":"????","artist":"???","album":null,"uri":"USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav","trackType":"wav"} Oct 08 13:26:09 volumio volumio[863]: info: CURRENT POSITION 12 Oct 08 13:26:09 volumio volumio[863]: info: CoreStateMachine::syncState stateService pause Oct 08 13:26:09 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus play Oct 08 13:26:09 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:09 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:09 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:09 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:09 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:09 volumio volumio[863]: info: ------------------------------ 56ms Oct 08 13:26:09 volumio sudo[2289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:09 volumio volumio[863]: info: Oct 08 13:26:09 volumio volumio[863]: ---------------------------- USB Audio Device Detached Oct 08 13:26:09 volumio sudo[2289]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:09 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Oct 08 13:26:09 volumio sudo[2289]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:09 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 08 13:26:10 volumio kernel: usb 6-1: new high-speed USB device number 4 using xhci_hcd Oct 08 13:26:10 volumio kernel: usb 6-1: new high-speed USB device number 5 using xhci_hcd Oct 08 13:26:10 volumio kernel: usb 6-1: New USB device found, idVendor=20b1, idProduct=000a Oct 08 13:26:10 volumio kernel: usb 6-1: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Oct 08 13:26:10 volumio kernel: usb 6-1: Product: xCORE USB Audio 2.0 Oct 08 13:26:10 volumio kernel: usb 6-1: Manufacturer: XMOS Oct 08 13:26:10 volumio volumio[863]: info: Oct 08 13:26:10 volumio volumio[863]: ---------------------------- USB Audio Device Attached Oct 08 13:26:10 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Oct 08 13:26:10 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent Oct 08 13:26:10 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 13:26:10 volumio volumio[863]: info: Output device has changed, restarting MPD Oct 08 13:26:10 volumio sudo[2306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 08 13:26:10 volumio sudo[2306]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:10 volumio volumio[863]: info: Output device has changed, restarting Shairport Sync Oct 08 13:26:10 volumio sudo[2306]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:10 volumio sudo[2309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 08 13:26:10 volumio sudo[2309]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:10 volumio systemd[1]: Stopping Music Player Daemon... Oct 08 13:26:11 volumio volumio[863]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 13:26:11 volumio volumio[863]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 08 13:26:11 volumio volumio[863]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 13:26:11 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:11 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:11 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:11 volumio sudo[2322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:11 volumio sudo[2322]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:11 volumio sudo[2322]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:11 volumio volumio[863]: error: Upnp client error: Error: This socket has been ended by the other party Oct 08 13:26:11 volumio volumio[863]: info: MPD Permissions set Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 13:26:11 volumio volumio[863]: info: Starting Shairport Sync Oct 08 13:26:11 volumio sudo[2337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 08 13:26:11 volumio sudo[2337]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 08 13:26:11 volumio systemd[1]: Starting Music Player Daemon... Oct 08 13:26:11 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 08 13:26:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 08 13:26:11 volumio sudo[2337]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:11 volumio volumio[863]: info: Shairport-Sync Started Oct 08 13:26:11 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Oct 08 13:26:13 volumio volumio[863]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 08 13:26:13 volumio volumio[863]: info: CoreStateMachine::getcurrentVolume Oct 08 13:26:13 volumio volumio[863]: info: CoreCommandRouter::volumioRetrievevolume Oct 08 13:26:13 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:13 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:13 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:13 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:13 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:13 volumio sudo[2357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:13 volumio sudo[2357]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:13 volumio sudo[2357]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:14 volumio kernel: usb 6-1: USB disconnect, device number 5 Oct 08 13:26:14 volumio volumio[863]: info: Oct 08 13:26:14 volumio volumio[863]: ---------------------------- USB Audio Device Detached Oct 08 13:26:14 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Oct 08 13:26:14 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 08 13:26:16 volumio systemd[1]: Started Music Player Daemon. Oct 08 13:26:16 volumio sudo[2309]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:16 volumio volumio[863]: info: Oct 08 13:26:19 volumio kernel: usb 6-2: new high-speed USB device number 6 using xhci_hcd Oct 08 13:26:19 volumio kernel: usb 6-2: New USB device found, idVendor=20b1, idProduct=000a Oct 08 13:26:19 volumio kernel: usb 6-2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Oct 08 13:26:19 volumio kernel: usb 6-2: Product: xCORE USB Audio 2.0 Oct 08 13:26:19 volumio kernel: usb 6-2: Manufacturer: XMOS Oct 08 13:26:19 volumio volumio[863]: info: Oct 08 13:26:19 volumio volumio[863]: ---------------------------- USB Audio Device Attached Oct 08 13:26:19 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Oct 08 13:26:19 volumio volumio[863]: info: CoreCommandRouter::Close All Modals sent Oct 08 13:26:19 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 13:26:19 volumio volumio[863]: info: Output device has changed, restarting MPD Oct 08 13:26:20 volumio volumio[863]: info: Output device has changed, restarting Shairport Sync Oct 08 13:26:20 volumio sudo[2383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 08 13:26:20 volumio sudo[2383]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:20 volumio sudo[2383]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:20 volumio sudo[2385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 08 13:26:20 volumio sudo[2385]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:20 volumio systemd[1]: Stopping Music Player Daemon... Oct 08 13:26:20 volumio volumio[863]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 08 13:26:20 volumio systemd[1]: Starting Music Player Daemon... Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 13:26:20 volumio volumio[863]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 08 13:26:20 volumio volumio[863]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 13:26:20 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:20 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:20 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:20 volumio sudo[2400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:20 volumio sudo[2400]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:20 volumio volumio[863]: info: MPD Permissions set Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio sudo[2400]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 13:26:20 volumio volumio[863]: info: Starting Shairport Sync Oct 08 13:26:20 volumio sudo[2415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 08 13:26:20 volumio sudo[2415]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 08 13:26:20 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 08 13:26:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 08 13:26:20 volumio sudo[2415]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:20 volumio volumio[863]: info: Shairport-Sync Started Oct 08 13:26:20 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Oct 08 13:26:22 volumio volumio[863]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 08 13:26:22 volumio volumio[863]: info: CoreStateMachine::getcurrentVolume Oct 08 13:26:22 volumio volumio[863]: info: CoreCommandRouter::volumioRetrievevolume Oct 08 13:26:22 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:22 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:22 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:22 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:22 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:22 volumio sudo[2432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:22 volumio sudo[2432]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:22 volumio sudo[2432]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:24 volumio systemd[1]: Started Music Player Daemon. Oct 08 13:26:24 volumio sudo[2385]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:24 volumio volumio[863]: info: Oct 08 13:26:25 volumio volumio[863]: info: CoreCommandRouter::volumioAddQueueItems Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::addQueueItems Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::addQueueItems Oct 08 13:26:25 volumio volumio[863]: info: Adding Item to queue: music-library/USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav Oct 08 13:26:25 volumio volumio[863]: info: Exploding uri music-library/USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav in service mpd Oct 08 13:26:25 volumio volumio[863]: info: ALBUMART /albumart?cacheid=718&web=%3F%3F%3F//extralarge&path=%2Fmnt%2FUSB%2F%E8%BD%AF%E4%BB%B6%2F%E6%B3%BD%E5%B0%94%E4%B8%B9%E3%80%8A%E4%BB%8A%E7%94%9F%E7%9B%B8%E7%88%B1%C2%B7%E6%88%91%E7%9A%84%E4%B9%9D%E5%AF%A8%E3%80%8B%2F%E9%98%B3%E5%85%89%E8%A5%BF%E8%97%8F.wav&metadata=false Oct 08 13:26:25 volumio volumio[863]: info: URI /mnt/USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::saveQueue Oct 08 13:26:25 volumio volumio[863]: info: CoreCommandRouter::volumioPushQueue Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::updateTrackBlock Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::getTrackBlock Oct 08 13:26:25 volumio volumio[863]: info: CoreCommandRouter::volumioPlay Oct 08 13:26:25 volumio volumio[863]: UNSET VOLATILE Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::play index 13 Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::stop Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 13:26:25 volumio volumio[863]: UNSET VOLATILE Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::stPlaybackTimer Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::updateTrackBlock Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::getTrackBlock Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:25 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:25 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::serviceStop Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::getTrack 12 Oct 08 13:26:25 volumio volumio[863]: info: CoreCommandRouter::serviceStop Oct 08 13:26:25 volumio volumio[863]: info: ControllerMpd::stop Oct 08 13:26:25 volumio volumio[863]: info: ControllerMpd::sendMpdCommand stop Oct 08 13:26:25 volumio volumio[863]: info: sending command... Oct 08 13:26:25 volumio volumio[863]: info: parsing response... Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::play index undefined Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::getTrack 13 Oct 08 13:26:25 volumio volumio[863]: info: CoreStateMachine::startPlaybackTimer Oct 08 13:26:25 volumio volumio[863]: info: CorePlayQueue::getTrack 13 Oct 08 13:26:25 volumio sudo[2442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:25 volumio sudo[2442]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:25 volumio volumio[863]: info: ControllerMpd::clearAddPlayTracks USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav Oct 08 13:26:25 volumio volumio[863]: info: ControllerMpd::sendMpdCommand stop Oct 08 13:26:25 volumio volumio[863]: info: sending command... Oct 08 13:26:25 volumio volumio[863]: info: parsing response... Oct 08 13:26:25 volumio sudo[2442]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:25 volumio volumio[863]: info: ControllerMpd::sendMpdCommand clear Oct 08 13:26:25 volumio volumio[863]: info: sending command... Oct 08 13:26:25 volumio volumio[863]: info: Oct 08 13:26:25 volumio volumio[863]: ---------------------------- MPD announces system playlist update Oct 08 13:26:25 volumio volumio[863]: info: Ignoring MPD Status Update Oct 08 13:26:25 volumio volumio[863]: info: parsing response... Oct 08 13:26:25 volumio volumio[863]: info: ControllerMpd::sendMpdCommand add "USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav" Oct 08 13:26:25 volumio volumio[863]: info: sending command... Oct 08 13:26:25 volumio volumio[863]: info: Oct 08 13:26:25 volumio volumio[863]: info: Oct 08 13:26:25 volumio volumio[863]: ---------------------------- MPD announces system playlist update Oct 08 13:26:25 volumio volumio[863]: info: Ignoring MPD Status Update Oct 08 13:26:25 volumio volumio[863]: info: ------------------------------ 10ms Oct 08 13:26:25 volumio volumio[863]: info: parsing response... Oct 08 13:26:25 volumio volumio[863]: info: ControllerMpd::sendMpdCommand play Oct 08 13:26:25 volumio volumio[863]: info: sending command... Oct 08 13:26:25 volumio volumio[863]: info: ------------------------------ 20ms Oct 08 13:26:25 volumio volumio[863]: info: parsing response... Oct 08 13:26:26 volumio volumio[863]: info: Oct 08 13:26:26 volumio volumio[863]: ---------------------------- MPD announces state update: player Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::getState Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::sendMpdCommand status Oct 08 13:26:26 volumio volumio[863]: info: sending command... Oct 08 13:26:26 volumio volumio[863]: info: Oct 08 13:26:26 volumio volumio[863]: ---------------------------- MPD announces state update: player Oct 08 13:26:26 volumio volumio[863]: info: parsing response... Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::getState Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::sendMpdCommand status Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::parseState Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 08 13:26:26 volumio volumio[863]: info: sending command... Oct 08 13:26:26 volumio volumio[863]: info: sending command... Oct 08 13:26:26 volumio volumio[863]: info: parsing response... Oct 08 13:26:26 volumio volumio[863]: info: parsing response... Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::parseState Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::parseTrackInfo Oct 08 13:26:26 volumio volumio[863]: info: sending command... Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::pushState Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::servicePushState Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::syncState Oct 08 13:26:26 volumio volumio[863]: info: CorePlayQueue::getTrack 13 Oct 08 13:26:26 volumio volumio[863]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"0 Kbps","isStreaming":false,"title":"????","artist":"???","album":null,"uri":"USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav","trackType":"wav"} Oct 08 13:26:26 volumio volumio[863]: info: CURRENT POSITION 13 Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::syncState stateService play Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus stop Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:26 volumio volumio[863]: info: CorePlayQueue::getTrack 13 Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:26 volumio volumio[863]: info: ------------------------------ 90ms Oct 08 13:26:26 volumio volumio[863]: info: parsing response... Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::parseTrackInfo Oct 08 13:26:26 volumio volumio[863]: info: ControllerMpd::pushState Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::servicePushState Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::syncState Oct 08 13:26:26 volumio volumio[863]: info: CorePlayQueue::getTrack 13 Oct 08 13:26:26 volumio volumio[863]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"0 Kbps","isStreaming":false,"title":"????","artist":"???","album":null,"uri":"USB/软件/泽尔丹《今生相爱·我的九寨》/阳光西藏.wav","trackType":"wav"} Oct 08 13:26:26 volumio volumio[863]: info: CURRENT POSITION 13 Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::syncState stateService play Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::syncState currentStatus play Oct 08 13:26:26 volumio volumio[863]: info: Received an update from plugin. extracting info from payload Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:26 volumio volumio[863]: info: CorePlayQueue::getTrack 13 Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:26 volumio sudo[2449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:26 volumio sudo[2449]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::pushState Oct 08 13:26:26 volumio volumio[863]: info: CoreStateMachine::getState Oct 08 13:26:26 volumio volumio[863]: info: CorePlayQueue::getTrack 13 Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::volumioPushState Oct 08 13:26:26 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 08 13:26:26 volumio sudo[2449]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:26 volumio sudo[2452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:26 volumio volumio[863]: info: ------------------------------ 96ms Oct 08 13:26:26 volumio sudo[2452]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:26 volumio sudo[2458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 08 13:26:26 volumio sudo[2458]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 08 13:26:26 volumio sudo[2452]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:26 volumio sudo[2458]: pam_unix(sudo:session): session closed for user root Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 08 13:26:43 volumio volumio[863]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 08 13:26:49 volumio volumio[863]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%3F%3F%3F/87abe610-871f-47f4-a07b-65723699f9e4.jpg' Oct 08 13:26:58 volumio volumio[863]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 13:26:58 volumio volumio[863]: { Error: connect ETIMEDOUT 199.96.63.163:80 Oct 08 13:26:58 volumio volumio[863]: at Object._errnoException (util.js:1022:11) Oct 08 13:26:58 volumio volumio[863]: at _exceptionWithHostPort (util.js:1044:20) Oct 08 13:26:58 volumio volumio[863]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 08 13:26:58 volumio volumio[863]: code: 'ETIMEDOUT', Oct 08 13:26:58 volumio volumio[863]: errno: 'ETIMEDOUT', Oct 08 13:26:58 volumio volumio[863]: syscall: 'connect', Oct 08 13:26:58 volumio volumio[863]: address: '199.96.63.163', Oct 08 13:26:58 volumio volumio[863]: port: 80 } Oct 08 13:26:58 volumio volumio[863]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 08 13:26:59 volumio sudo[2536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-08 13:25 Oct 08 13:26:59 volumio sudo[2536]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="ba22215fabbe766d668749499a1c25fcefd90f0a" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="043dcaee624f27d121213b83af11a9f2feac0945" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 18 01:49:12 CET 2020" VOLUMIO_VERSION="2.729" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="2b6d4379c45b84d89199e8b2dd2be839"