-- Logs begin at Fri 2024-07-12 12:36:06 UTC, end at Fri 2024-07-12 12:44:04 UTC. --
Jul 12 12:43:00 volumio volumio[887]: info: CoreCommandRouter::volumioGetQueue
Jul 12 12:43:00 volumio volumio[887]: info: CoreStateMachine::getQueue
Jul 12 12:43:00 volumio volumio[887]: info: CorePlayQueue::getQueue
Jul 12 12:43:01 volumio kernel: usb usb2-port2: Cannot enable. Maybe the USB cable is bad?
Jul 12 12:43:02 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 12:43:02 volumio volumio[887]: info: CURURI: artists://
Jul 12 12:43:03 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 12:43:03 volumio volumio[887]: info: CURURI: music-library
Jul 12 12:43:03 volumio volumio[887]: error: Failed LSINFO: null
Jul 12 12:43:06 volumio kernel: usb usb2-port2: Cannot enable. Maybe the USB cable is bad?
Jul 12 12:43:06 volumio kernel: usb usb2-port2: attempt power cycle
Jul 12 12:43:09 volumio hotspot[883]: wlan0: STA 92:96:f8:53:6f:e3 IEEE 802.11: disassociated
Jul 12 12:43:09 volumio hotspot[883]: wlan0: AP-STA-DISCONNECTED 92:96:f8:53:6f:e3
Jul 12 12:43:09 volumio hostapd[917]: wlan0: STA 92:96:f8:53:6f:e3 IEEE 802.11: disassociated
Jul 12 12:43:09 volumio hostapd[917]: wlan0: STA 92:96:f8:53:6f:e3 IEEE 802.11: disassociated
Jul 12 12:43:09 volumio hotspot[883]: wlan0: STA 92:96:f8:53:6f:e3 IEEE 802.11: disassociated
Jul 12 12:43:10 volumio kernel: usb usb2-port2: Cannot enable. Maybe the USB cable is bad?
Jul 12 12:43:15 volumio kernel: usb usb2-port2: Cannot enable. Maybe the USB cable is bad?
Jul 12 12:43:15 volumio kernel: usb usb2-port2: unable to enumerate USB device
Jul 12 12:43:15 volumio kernel: usb 2-1: new SuperSpeed Gen 1 USB device number 42 using xhci_hcd
Jul 12 12:43:15 volumio kernel: usb 2-1: New USB device found, idVendor=125f, idProduct=312b, bcdDevice= 1.00
Jul 12 12:43:15 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jul 12 12:43:15 volumio kernel: usb 2-1: Product: ADATA USB Flash Drive
Jul 12 12:43:15 volumio kernel: usb 2-1: Manufacturer: ADATA
Jul 12 12:43:15 volumio kernel: usb 2-1: SerialNumber: 1461318462330034
Jul 12 12:43:15 volumio kernel: usb-storage 2-1:1.0: USB Mass Storage device detected
Jul 12 12:43:15 volumio kernel: scsi host0: usb-storage 2-1:1.0
Jul 12 12:43:16 volumio kernel: scsi 0:0:0:0: Direct-Access ADATA USB Flash Drive 0.00 PQ: 0 ANSI: 6
Jul 12 12:43:16 volumio kernel: sd 0:0:0:0: [sda] 30344192 512-byte logical blocks: (15.5 GB/14.5 GiB)
Jul 12 12:43:16 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off
Jul 12 12:43:16 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 23 00 00 00
Jul 12 12:43:16 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Jul 12 12:43:16 volumio kernel: sda: sda1
Jul 12 12:43:16 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Jul 12 12:43:16 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Jul 12 12:43:16 volumio udisks-glue[590]: Device file /dev/sda inserted
Jul 12 12:43:16 volumio udisks-glue[590]: Device file /dev/sda1 inserted
Jul 12 12:43:16 volumio udisks-glue[590]: Trying to automount /dev/sda1...
Jul 12 12:43:16 volumio udisks-glue[590]: Successfully automounted /dev/sda1 at /media/ADATA UFD
Jul 12 12:43:16 volumio udisks-glue[590]: Device file /dev/sda1 mounted at /media/ADATA UFD
Jul 12 12:43:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:16 volumio volumio[887]: info:
Jul 12 12:43:16 volumio volumio[887]: ---------------------------- MPD announces state update: update
Jul 12 12:43:16 volumio udisks-glue[590]: Updating DB (#1) ...
Jul 12 12:43:16 volumio udisks-glue[590]: volume:100% repeat: off random: off single: off consume: off
Jul 12 12:43:16 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:16 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:16 volumio volumio[887]: info: sendMpdCommand status took 5 milliseconds
Jul 12 12:43:16 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds
Jul 12 12:43:16 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:17 volumio volumio[887]: info: Command Router : Notfying DB Updatetrue
Jul 12 12:43:17 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:17 volumio volumio[887]: info: ControllerMpd::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::servicePushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 12 12:43:17 volumio volumio[887]: verbose: CURRENT POSITION 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: No code
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: ------------------------------ 89ms
Jul 12 12:43:17 volumio volumio[887]: info: MPD Database updated - AlbumList cache refreshed
Jul 12 12:43:17 volumio volumio[887]: info:
Jul 12 12:43:17 volumio volumio[887]: ---------------------------- MPD announces state update: database
Jul 12 12:43:17 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:17 volumio volumio[887]: info:
Jul 12 12:43:17 volumio volumio[887]: ---------------------------- MPD announces state update: update
Jul 12 12:43:17 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:17 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:17 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:17 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:17 volumio volumio[887]: info: sendMpdCommand status took 11 milliseconds
Jul 12 12:43:17 volumio volumio[887]: info: sendMpdCommand status took 10 milliseconds
Jul 12 12:43:17 volumio volumio[887]: info: sendMpdCommand status took 10 milliseconds
Jul 12 12:43:17 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:17 volumio volumio[887]: info: Command Router : Notfying DB Updatefalse
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::Close All Modals sent
Jul 12 12:43:17 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:17 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:17 volumio volumio[887]: info: ControllerMpd::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::servicePushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: 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}
Jul 12 12:43:17 volumio volumio[887]: verbose: CURRENT POSITION 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: No code
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: ControllerMpd::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::servicePushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: 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}
Jul 12 12:43:17 volumio volumio[887]: verbose: CURRENT POSITION 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::syncState stateService stop
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: No code
Jul 12 12:43:17 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:17 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:17 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:17 volumio volumio[887]: info: ------------------------------ 64ms
Jul 12 12:43:17 volumio volumio[887]: info: ------------------------------ 65ms
Jul 12 12:43:19 volumio kernel: usb usb2-port2: Cannot enable. Maybe the USB cable is bad?
Jul 12 12:43:22 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 12:43:22 volumio volumio[887]: info: CURURI: music-library
Jul 12 12:43:24 volumio kernel: usb usb2-port2: Cannot enable. Maybe the USB cable is bad?
Jul 12 12:43:28 volumio kernel: usb usb2-port2: Cannot enable. Maybe the USB cable is bad?
Jul 12 12:43:28 volumio kernel: usb usb2-port2: attempt power cycle
Jul 12 12:43:29 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 12:43:29 volumio volumio[887]: info: CURURI: music-library/USB
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::ClearQueue
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::stop
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 12:43:31 volumio volumio[887]: UNSET VOLATILE
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::clearPlayQueue
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::saveQueue
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::addQueueItems
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::addQueueItems
Jul 12 12:43:31 volumio volumio[887]: info: Adding Item to queue: music-library/USB/ADATA UFD
Jul 12 12:43:31 volumio volumio[887]: info: Exploding uri music-library/USB/ADATA UFD in service mpd
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=Leo%20Rojas/Das%20Beste/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FLeo%20Rojas%20-%20Amigos.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Leo Rojas - Amigos.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FLeo%20Rojas%20-%20Celeste.mp3&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Leo Rojas - Celeste.mp3
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FLeo%20Rojas%20-%20Colors%20Of%20The%20Rainbow.mp3&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Leo Rojas - Colors Of The Rainbow.mp3
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=Leo%20Rojas/Spirit%20of%20the%20Hawk/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FLeo%20Rojas%20-%20Der%20einsame%20Hirte.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Leo Rojas - Der einsame Hirte.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=Leo%20Rojas/Das%20Beste/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FLeo%20Rojas%20-%20Der%20mit%20dem%20Wolf%20tanzt.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Leo Rojas - Der mit dem Wolf tanzt.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=Leo%20Rojas/Das%20Beste/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FLeo%20Rojas%20-%20En%20Aranjuez%20Con%20Tu%20Amor.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Leo Rojas - En Aranjuez Con Tu Amor.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FLeo%20Rojas%20-%20We%20Are%20the%20World.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Leo Rojas - We Are the World.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=Meteora//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FMe.Te.Ora.%20-%20Cioccolato.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Me.Te.Ora. - Cioccolato.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FRachele%20Ginovessi%20-%20Meteora.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Rachele Ginovessi - Meteora.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=%E7%90%86%E6%9F%A5%E5%BE%B7.%E5%85%8B%E8%8E%B1%E5%BE%B7%E6%9B%BC/%E9%92%A2%E7%90%B4%E8%BD%BB%E9%9F%B3%E4%B9%90%E6%9B%B2%E9%80%89/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FRichard%20Clayderman%20-%20%E7%BD%97%E5%AF%86%E6%AC%A7%E4%B8%8E%E6%9C%B1%E4%B8%BD%E5%8F%B6%20(%E9%92%A2%E7%90%B4%E6%9B%B2).flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Richard Clayderman - 罗密欧与朱丽叶 (钢琴曲).flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=Sofia%20Metropolitan%20Orchestra/Great%20Masterpieces%2C%20Live%20Recordings%20Vol.%20%202/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2FSofia%20Metropolitan%20Orchestra%20-%20Leichte%20Kavallerie%20Overture%20Franz%20von%20Suppe.mp3&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/Sofia Metropolitan Orchestra - Leichte Kavallerie Overture Franz von Suppe.mp3
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=%E7%99%BD%E6%99%93/%E5%AF%82%E5%AF%9E%E4%BC%A4%E6%83%85/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E4%B8%A2%E4%BA%86%E5%B9%B8%E7%A6%8F%E7%9A%84%E7%8C%AA.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 丢了幸福的猪.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E4%BB%8A%E5%A4%9C%E4%BD%A0%E4%BC%9A%E4%B8%8D%E4%BC%9A%E6%9D%A5.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 今夜你会不会来.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E4%BC%9A%E5%91%BC%E5%90%B8%E7%9A%84%E7%97%9B.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 会呼吸的痛.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E5%81%87%E5%A6%82%E7%88%B1%E6%9C%89%E5%A4%A9%E6%84%8F.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 假如爱有天意.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E5%AF%B9%E4%BD%A0.mp3&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 对你.mp3
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E6%A2%A6%E4%B8%80%E5%9C%BA.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 梦一场.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=%E7%99%BD%E6%99%93/%E5%AF%82%E5%AF%9E%E4%BC%A4%E6%83%85/extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E7%8C%9C%E4%B8%8D%E9%80%8F.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 猜不透.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E7%BA%A2%E9%9B%A8.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 红雨.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E7%BB%99%E6%88%91%E4%B8%80%E4%B8%AA%E7%90%86%E7%94%B1%E5%BF%98%E8%AE%B0.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 给我一个理由忘记.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E9%83%BD%E6%98%AF%E5%A4%9C%E5%BD%92%E4%BA%BA.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 都是夜归人.flac
Jul 12 12:43:31 volumio volumio[887]: info: ALBUMART /albumart?cacheid=901&web=//extralarge&path=%2Fmnt%2FUSB%2FADATA%20UFD%2F%E7%99%BD%E6%99%93%20-%20%E9%BB%98.flac&metadata=false
Jul 12 12:43:31 volumio volumio[887]: info: URI /mnt/USB/ADATA UFD/白晓 - 默.flac
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::saveQueue
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioPushQueue
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrackBlock
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioPlay
Jul 12 12:43:31 volumio volumio[887]: UNSET VOLATILE
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::play index 0
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::stop
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 12:43:31 volumio volumio[887]: UNSET VOLATILE
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::play index undefined
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::clearAddPlayTracks USB/ADATA UFD/Leo Rojas - Amigos.flac
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand stop took 3 milliseconds
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear
Jul 12 12:43:31 volumio volumio[887]: info:
Jul 12 12:43:31 volumio volumio[887]: ---------------------------- MPD announces system playlist update
Jul 12 12:43:31 volumio volumio[887]: info: Ignoring MPD Status Update
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand clear took 4 milliseconds
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand add "USB/ADATA UFD/Leo Rojas - Amigos.flac"
Jul 12 12:43:31 volumio volumio[887]: error: updateQueue error: null
Jul 12 12:43:31 volumio volumio[887]: info:
Jul 12 12:43:31 volumio volumio[887]: ---------------------------- MPD announces system playlist update
Jul 12 12:43:31 volumio volumio[887]: info: Ignoring MPD Status Update
Jul 12 12:43:31 volumio volumio[887]: info: ------------------------------ 3ms
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand add "USB/ADATA UFD/Leo Rojas - Amigos.flac" took 2 milliseconds
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play
Jul 12 12:43:31 volumio volumio[887]: info:
Jul 12 12:43:31 volumio volumio[887]: ---------------------------- MPD announces state update: player
Jul 12 12:43:31 volumio volumio[887]: info: ------------------------------ 8ms
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand play took 7 milliseconds
Jul 12 12:43:31 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:31 volumio kernel: usb 1-1.4: 1:1: cannot get freq at ep 0x1
Jul 12 12:43:31 volumio volumio[887]: info:
Jul 12 12:43:31 volumio volumio[887]: ---------------------------- MPD announces state update: player
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand status took 8 milliseconds
Jul 12 12:43:31 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo
Jul 12 12:43:31 volumio volumio[887]: info: ControllerMpd::pushState
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::servicePushState
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:31 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":160,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 Amigos","artist":"Leo Rojas","album":"Das Beste","uri":"USB/ADATA UFD/Leo Rojas - Amigos.flac","trackType":"flac"}
Jul 12 12:43:31 volumio volumio[887]: verbose: CURRENT POSITION 0
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::syncState stateService play
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:31 volumio volumio[887]: info: ------------------------------ 22ms
Jul 12 12:43:31 volumio volumio[887]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jul 12 12:43:31 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo
Jul 12 12:43:31 volumio volumio[887]: info: ControllerMpd::pushState
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::servicePushState
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:31 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":208,"duration":160,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"03 Amigos","artist":"Leo Rojas","album":"Das Beste","uri":"USB/ADATA UFD/Leo Rojas - Amigos.flac","trackType":"flac"}
Jul 12 12:43:31 volumio volumio[887]: verbose: CURRENT POSITION 0
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::syncState stateService play
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play
Jul 12 12:43:31 volumio volumio[887]: info: Received an update from plugin. extracting info from payload
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:31 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:31 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:31 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:31 volumio volumio[887]: info: ------------------------------ 23ms
Jul 12 12:43:49 volumio volumio[887]: info: VolumeController::SetAlsaVolume5
Jul 12 12:43:49 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:49 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:49 volumio volumio[887]: info: VolumeController::SetAlsaVolume15
Jul 12 12:43:49 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:49 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:49 volumio volumio[887]: info: VolumeController::SetAlsaVolume25
Jul 12 12:43:49 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:49 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:49 volumio volumio[887]: info: VolumeController::SetAlsaVolume35
Jul 12 12:43:49 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:49 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:49 volumio volumio[887]: info: VolumeController::SetAlsaVolume45
Jul 12 12:43:49 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:49 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:49 volumio volumio[887]: info: VolumeController::SetAlsaVolume50
Jul 12 12:43:49 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:49 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:49 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:50 volumio volumio[887]: info: VolumeController::SetAlsaVolume60
Jul 12 12:43:50 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:50 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:50 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:50 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:51 volumio volumio[887]: info: VolumeController::SetAlsaVolume65
Jul 12 12:43:51 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:51 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:51 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:51 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:51 volumio volumio[887]: info: VolumeController::SetAlsaVolume80
Jul 12 12:43:51 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:51 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:51 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:51 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:52 volumio volumio[887]: info: VolumeController::SetAlsaVolume85
Jul 12 12:43:52 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:52 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:52 volumio volumio[887]: info: VolumeController::SetAlsaVolume90
Jul 12 12:43:52 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:52 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:52 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:52 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:54 volumio volumio[887]: info: CoreCommandRouter::volumioNext
Jul 12 12:43:54 volumio volumio[887]: info: CoreStateMachine::next
Jul 12 12:43:54 volumio volumio[887]: info: CoreStateMachine::stop
Jul 12 12:43:54 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 12:43:54 volumio volumio[887]: UNSET VOLATILE
Jul 12 12:43:54 volumio volumio[887]: info: CoreStateMachine::stPlaybackTimer
Jul 12 12:43:54 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock
Jul 12 12:43:54 volumio volumio[887]: info: CorePlayQueue::getTrackBlock
Jul 12 12:43:54 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:54 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:54 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:54 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:54 volumio volumio[887]: info: CoreStateMachine::serviceStop
Jul 12 12:43:54 volumio volumio[887]: info: CorePlayQueue::getTrack 0
Jul 12 12:43:54 volumio volumio[887]: info: CoreCommandRouter::serviceStop
Jul 12 12:43:54 volumio volumio[887]: info: ControllerMpd::stop
Jul 12 12:43:54 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand stop took 54 milliseconds
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::play index undefined
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrack 1
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::startPlaybackTimer
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrack 1
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::clearAddPlayTracks USB/ADATA UFD/Leo Rojas - Celeste.mp3
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand stop
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::updateTrackBlock
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrackBlock
Jul 12 12:43:55 volumio volumio[887]: info:
Jul 12 12:43:55 volumio volumio[887]: ---------------------------- MPD announces state update: player
Jul 12 12:43:55 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand stop took 4 milliseconds
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand clear
Jul 12 12:43:55 volumio volumio[887]: info:
Jul 12 12:43:55 volumio volumio[887]: ---------------------------- MPD announces system playlist update
Jul 12 12:43:55 volumio volumio[887]: info: Ignoring MPD Status Update
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand status took 2 milliseconds
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand clear took 2 milliseconds
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand add "USB/ADATA UFD/Leo Rojas - Celeste.mp3"
Jul 12 12:43:55 volumio volumio[887]: error: updateQueue error: null
Jul 12 12:43:55 volumio volumio[887]: info:
Jul 12 12:43:55 volumio volumio[887]: ---------------------------- MPD announces system playlist update
Jul 12 12:43:55 volumio volumio[887]: info: Ignoring MPD Status Update
Jul 12 12:43:55 volumio volumio[887]: info: ------------------------------ 3ms
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand add "USB/ADATA UFD/Leo Rojas - Celeste.mp3" took 2 milliseconds
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand play
Jul 12 12:43:55 volumio volumio[887]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 12 12:43:55 volumio volumio[887]: info: ------------------------------ 8ms
Jul 12 12:43:55 volumio volumio[887]: info: ------------------------------ 4ms
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand play took 2 milliseconds
Jul 12 12:43:55 volumio volumio[887]: info:
Jul 12 12:43:55 volumio volumio[887]: ---------------------------- MPD announces state update: player
Jul 12 12:43:55 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand status took 4 milliseconds
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 12 12:43:55 volumio volumio[887]: info:
Jul 12 12:43:55 volumio volumio[887]: ---------------------------- MPD announces state update: player
Jul 12 12:43:55 volumio volumio[887]: info: ControllerMpd::getState
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand status
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo
Jul 12 12:43:55 volumio volumio[887]: info: ControllerMpd::pushState
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::servicePushState
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrack 1
Jul 12 12:43:55 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Leo Rojas - Celeste.mp3","artist":null,"album":null,"uri":"USB/ADATA UFD/Leo Rojas - Celeste.mp3","trackType":"mp3"}
Jul 12 12:43:55 volumio volumio[887]: verbose: CURRENT POSITION 1
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::syncState stateService play
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus stop
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrack 1
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:55 volumio volumio[887]: info: ------------------------------ 13ms
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand status took 7 milliseconds
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::parseState
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 12 12:43:55 volumio volumio[887]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 12 12:43:55 volumio volumio[887]: verbose: ControllerMpd::parseTrackInfo
Jul 12 12:43:55 volumio volumio[887]: info: ControllerMpd::pushState
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::servicePushState
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrack 1
Jul 12 12:43:55 volumio volumio[887]: verbose: STATE SERVICE {"status":"play","position":0,"seek":139,"duration":245,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Leo Rojas - Celeste.mp3","artist":null,"album":null,"uri":"USB/ADATA UFD/Leo Rojas - Celeste.mp3","trackType":"mp3"}
Jul 12 12:43:55 volumio volumio[887]: verbose: CURRENT POSITION 1
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::syncState stateService play
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::syncState currentStatus play
Jul 12 12:43:55 volumio volumio[887]: info: Received an update from plugin. extracting info from payload
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrack 1
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:55 volumio volumio[887]: info: CoreStateMachine::pushState
Jul 12 12:43:55 volumio volumio[887]: info: CorePlayQueue::getTrack 1
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::volumioPushState
Jul 12 12:43:55 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 12 12:43:55 volumio volumio[887]: info: ------------------------------ 21ms
Jul 12 12:44:00 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 12:44:00 volumio volumio[887]: info: CURURI: playlists
Jul 12 12:44:00 volumio volumio[887]: info: Listing playlists
Jul 12 12:44:02 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 12:44:02 volumio volumio[887]: info: CURURI: playlists
Jul 12 12:44:02 volumio volumio[887]: info: Listing playlists
Jul 12 12:44:02 volumio volumio[887]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 12 12:44:02 volumio volumio[887]: info: CURURI: playlists
Jul 12 12:44:02 volumio volumio[887]: info: Listing playlists
Jul 12 12:44:04 volumio volumio[887]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 12 12:44:04 volumio volumio[887]: { Error: connect ETIMEDOUT 69.63.181.12:443
Jul 12 12:44:04 volumio volumio[887]: at Object._errnoException (util.js:1022:11)
Jul 12 12:44:04 volumio volumio[887]: at _exceptionWithHostPort (util.js:1044:20)
Jul 12 12:44:04 volumio volumio[887]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Jul 12 12:44:04 volumio volumio[887]: code: 'ETIMEDOUT',
Jul 12 12:44:04 volumio volumio[887]: errno: 'ETIMEDOUT',
Jul 12 12:44:04 volumio volumio[887]: syscall: 'connect',
Jul 12 12:44:04 volumio volumio[887]: address: '69.63.181.12',
Jul 12 12:44:04 volumio volumio[887]: port: 443 }
Jul 12 12:44:04 volumio volumio[887]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 12 12:44:04 volumio sudo[1576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-12 12:43
Jul 12 12:44:04 volumio sudo[1576]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758"
VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6"
VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021"
VOLUMIO_VERSION="2.907"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"