-- Logs begin at Mon 2024-07-22 20:17:11 HKT, end at Mon 2024-07-22 20:19:15 HKT. --
Jul 22 20:18:09 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:09 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:09 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:09 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:20 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:20 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:20 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:20 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:21 volumio kernel: usb 1-3.3: USB disconnect, device number 4
Jul 22 20:18:21 volumio volumio[931]: info: Partition removed: {"syspath":"/sys/devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/3082A9BB82A985C6 /dev/disk/by-path/pci-0000:00:14.0-usb-0:3.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/music /dev/disk/by-partuuid/d88a1120-01 /dev/disk/by-id/usb-SMI_USB_DISK-0:0-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"2","ID_BUS":"usb","ID_FS_LABEL":"music","ID_FS_LABEL_ENC":"music","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"3082A9BB82A985C6","ID_FS_UUID_ENC":"3082A9BB82A985C6","ID_INSTANCE":"0:0","ID_MODEL":"USB_DISK","ID_MODEL_ENC":"USB\\x20DISK\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"1000","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"31330304","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"d88a1120-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"d88a1120","ID_PATH":"pci-0000:00:14.0-usb-0:3.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"pci-0000_00_14_0-usb-0_3_3_1_0-scsi-0_0_0_0","ID_REVISION":"1100","ID_SERIAL":"SMI_USB_DISK-0:0","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"SMI","ID_VENDOR_ENC":"SMI\\x20\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"090c","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"3265","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"3833364"}
Jul 22 20:18:21 volumio kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Jul 22 20:18:21 volumio kernel: sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
Jul 22 20:18:21 volumio sudo[1897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1
Jul 22 20:18:21 volumio sudo[1897]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 20:18:21 volumio ntfs-3g[1168]: Unmounting /dev/sdb1 (music)
Jul 22 20:18:21 volumio ntfs-3g[1168]: Failed to sync device /dev/sdb1: Input/output error
Jul 22 20:18:21 volumio ntfs-3g[1168]: Failed to close volume /dev/sdb1: Input/output error
Jul 22 20:18:21 volumio systemd[1]: media-music.mount: Succeeded.
Jul 22 20:18:21 volumio sudo[1897]: pam_unix(sudo:session): session closed for user root
Jul 22 20:18:23 volumio kernel: usb 1-3.3: new high-speed USB device number 5 using xhci_hcd
Jul 22 20:18:23 volumio kernel: usb 1-3.3: New USB device found, idVendor=090c, idProduct=1000, bcdDevice=11.00
Jul 22 20:18:23 volumio kernel: usb 1-3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jul 22 20:18:23 volumio kernel: usb 1-3.3: Product: USB DISK
Jul 22 20:18:23 volumio kernel: usb 1-3.3: Manufacturer: SMI Corporation
Jul 22 20:18:23 volumio kernel: usb-storage 1-3.3:1.0: USB Mass Storage device detected
Jul 22 20:18:23 volumio kernel: scsi host1: usb-storage 1-3.3:1.0
Jul 22 20:18:25 volumio kernel: scsi 1:0:0:0: Direct-Access SMI USB DISK 1100 PQ: 0 ANSI: 4
Jul 22 20:18:25 volumio kernel: sd 1:0:0:0: Attached scsi generic sg1 type 0
Jul 22 20:18:25 volumio kernel: sd 1:0:0:0: [sdb] 31334400 512-byte logical blocks: (16.0 GB/14.9 GiB)
Jul 22 20:18:25 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off
Jul 22 20:18:25 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00
Jul 22 20:18:25 volumio kernel: sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Jul 22 20:18:25 volumio kernel: sdb: sdb1
Jul 22 20:18:25 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI removable disk
Jul 22 20:18:25 volumio volumio[931]: info: Mounting Device music
Jul 22 20:18:25 volumio sudo[1908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/music -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Jul 22 20:18:25 volumio sudo[1908]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 20:18:25 volumio ntfs-3g[1911]: Version 2017.3.23AR.3 integrated FUSE 28
Jul 22 20:18:25 volumio ntfs-3g[1911]: Mounted /dev/sdb1 (Read-Write, label "music", NTFS 3.1)
Jul 22 20:18:25 volumio ntfs-3g[1911]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Jul 22 20:18:25 volumio ntfs-3g[1911]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096
Jul 22 20:18:25 volumio ntfs-3g[1911]: Global ownership and permissions enforced, configuration type 7
Jul 22 20:18:25 volumio sudo[1908]: pam_unix(sudo:session): session closed for user root
Jul 22 20:18:25 volumio volumio[931]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/music
Jul 22 20:18:26 volumio volumio[931]: info: Scanning removed location : "USB/music"
Jul 22 20:18:26 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:18:26 volumio volumio[931]: info:
Jul 22 20:18:26 volumio volumio[931]: ---------------------------- MPD announces state update: update
Jul 22 20:18:26 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:18:26 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:18:26 volumio volumio[931]: info: sendMpdCommand status took 6 milliseconds
Jul 22 20:18:26 volumio volumio[931]: info: sendMpdCommand status took 4 milliseconds
Jul 22 20:18:26 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:18:26 volumio volumio[931]: info: Command Router : Notfying DB Updatetrue
Jul 22 20:18:26 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:18:26 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:18:26 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:18:26 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:26 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:26 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:26 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:26 volumio volumio[931]: 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 22 20:18:26 volumio volumio[931]: verbose: CURRENT POSITION 0
Jul 22 20:18:26 volumio volumio[931]: info: CoreStateMachine::syncState stateService stop
Jul 22 20:18:26 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop
Jul 22 20:18:26 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:26 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:26 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:18:26 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:26 volumio volumio[931]: info: No code
Jul 22 20:18:26 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:26 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:26 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:26 volumio volumio[931]: info: ------------------------------ 107ms
Jul 22 20:18:28 volumio volumio[931]: info: CoreCommandRouter::Close All Modals sent
Jul 22 20:18:30 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:18:30 volumio volumio[931]: info: CURURI: music-library
Jul 22 20:18:30 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:18:31 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:18:31 volumio volumio[931]: info: CURURI: music-library/USB
Jul 22 20:18:31 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:18:31 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:31 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:32 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:32 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:32 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:18:32 volumio volumio[931]: info: CURURI: music-library/USB/music
Jul 22 20:18:32 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:18:33 volumio ntpd[1503]: Soliciting pool server 193.182.111.143
Jul 22 20:18:33 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:18:33 volumio volumio[931]: info: CURURI: music-library/USB/music/《步步高_试机碟》
Jul 22 20:18:33 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:18:33 volumio volumio[931]: info: Preloading song: music-library/USB/music/《步步高_试机碟》/步步高_试机碟.wav
Jul 22 20:18:33 volumio volumio[931]: info: Exploding uri music-library/USB/music/《步步高_试机碟》/步步高_试机碟.wav in service mpd
Jul 22 20:18:33 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E3%80%8A%E6%AD%A5%E6%AD%A5%E9%AB%98_%E8%AF%95%E6%9C%BA%E7%A2%9F%E3%80%8B%2F%E6%AD%A5%E6%AD%A5%E9%AB%98_%E8%AF%95%E6%9C%BA%E7%A2%9F.wav&metadata=false
Jul 22 20:18:33 volumio volumio[931]: info: URI /mnt/USB/music/《步步高_试机碟》/步步高_试机碟.wav
Jul 22 20:18:34 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::ClearQueue
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::stop
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::clearPlayQueue
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::saveQueue
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::volumioPushQueue
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::addQueueItems
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::addQueueItems
Jul 22 20:18:34 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:18:34 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/《步步高_试机碟》/步步高_试机碟.wav
Jul 22 20:18:34 volumio volumio[931]: info: Using cached record of: music-library/USB/music/《步步高_试机碟》/步步高_试机碟.wav
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::volumioPushQueue
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::saveQueue
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::updateTrackBlock
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::getTrackBlock
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::volumioPlay
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::play index 0
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::stop
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::play index undefined
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::startPlaybackTimer
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::clearAddPlayTracks USB/music/《步步高_试机碟》/步步高_试机碟.wav
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand stop
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand stop took 5 milliseconds
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand clear
Jul 22 20:18:34 volumio volumio[931]: info:
Jul 22 20:18:34 volumio volumio[931]: ---------------------------- MPD announces system playlist update
Jul 22 20:18:34 volumio volumio[931]: info: Ignoring MPD Status Update
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand clear took 4 milliseconds
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand add "USB/music/《步步高_试机碟》/步步高_试机碟.wav"
Jul 22 20:18:34 volumio volumio[931]: error: updateQueue error: null
Jul 22 20:18:34 volumio volumio[931]: info:
Jul 22 20:18:34 volumio volumio[931]: ---------------------------- MPD announces system playlist update
Jul 22 20:18:34 volumio volumio[931]: info: Ignoring MPD Status Update
Jul 22 20:18:34 volumio volumio[931]: info: ------------------------------ 7ms
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand add "USB/music/《步步高_试机碟》/步步高_试机碟.wav" took 4 milliseconds
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand play
Jul 22 20:18:34 volumio volumio[931]: error: Upnp client error: Error: This socket has been ended by the other party
Jul 22 20:18:34 volumio volumio[931]: info:
Jul 22 20:18:34 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:18:34 volumio volumio[931]: info: ------------------------------ 9ms
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand play took 7 milliseconds
Jul 22 20:18:34 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:18:34 volumio volumio[931]: info:
Jul 22 20:18:34 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand status took 45 milliseconds
Jul 22 20:18:34 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand status took 3 milliseconds
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:18:34 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:34 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3443,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"步步高_试机碟.wav","artist":null,"album":null,"uri":"USB/music/《步步高_试机碟》/步步高_试机碟.wav","trackType":"wav"}
Jul 22 20:18:34 volumio volumio[931]: verbose: CURRENT POSITION 0
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop
Jul 22 20:18:34 volumio volumio[931]: info: ------------------------------ 57ms
Jul 22 20:18:34 volumio volumio[931]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 22 20:18:34 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:18:34 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:34 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":3443,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"步步高_试机碟.wav","artist":null,"album":null,"uri":"USB/music/《步步高_试机碟》/步步高_试机碟.wav","trackType":"wav"}
Jul 22 20:18:34 volumio volumio[931]: verbose: CURRENT POSITION 0
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus play
Jul 22 20:18:34 volumio volumio[931]: info: Received an update from plugin. extracting info from payload
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:34 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:34 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:34 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:34 volumio volumio[931]: info: ------------------------------ 49ms
Jul 22 20:18:36 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:36 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:36 volumio ntpd[1503]: Soliciting pool server 211.68.71.118
Jul 22 20:18:37 volumio ntpd[1503]: Soliciting pool server 202.118.1.81
Jul 22 20:18:42 volumio volumio[931]: info: MPD Database updated - AlbumList cache refreshed
Jul 22 20:18:42 volumio volumio[931]: info:
Jul 22 20:18:42 volumio volumio[931]: ---------------------------- MPD announces state update: database
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:18:42 volumio volumio[931]: info:
Jul 22 20:18:42 volumio volumio[931]: ---------------------------- MPD announces state update: update
Jul 22 20:18:42 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:18:42 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:18:42 volumio volumio[931]: info: sendMpdCommand status took 7 milliseconds
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:18:42 volumio volumio[931]: info: Command Router : Notfying DB Updatefalse
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::Close All Modals sent
Jul 22 20:18:42 volumio volumio[931]: info: sendMpdCommand status took 51 milliseconds
Jul 22 20:18:42 volumio volumio[931]: info: sendMpdCommand status took 50 milliseconds
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:18:42 volumio volumio[931]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 22 20:18:42 volumio volumio[931]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:18:42 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:18:42 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:18:42 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:42 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9152,"duration":3443,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"步步高_试机碟.wav","artist":null,"album":null,"uri":"USB/music/《步步高_试机碟》/步步高_试机碟.wav","trackType":"wav"}
Jul 22 20:18:42 volumio volumio[931]: verbose: CURRENT POSITION 0
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus play
Jul 22 20:18:42 volumio volumio[931]: info: Received an update from plugin. extracting info from payload
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:42 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:42 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:42 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:18:42 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:42 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9152,"duration":3443,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"步步高_试机碟.wav","artist":null,"album":null,"uri":"USB/music/《步步高_试机碟》/步步高_试机碟.wav","trackType":"wav"}
Jul 22 20:18:42 volumio volumio[931]: verbose: CURRENT POSITION 0
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus play
Jul 22 20:18:42 volumio volumio[931]: info: Received an update from plugin. extracting info from payload
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:42 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:42 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:18:42 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:42 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:18:42 volumio volumio[931]: info: ------------------------------ 95ms
Jul 22 20:18:42 volumio volumio[931]: info: ------------------------------ 96ms
Jul 22 20:18:43 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:43 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:43 volumio sudo[1958]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Jul 22 20:18:43 volumio sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 22 20:18:45 volumio volumio[931]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6
Jul 22 20:18:45 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:18:45 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:18:51 volumio sshd[1996]: Accepted password for volumio from 192.168.255.3 port 60184 ssh2
Jul 22 20:18:51 volumio sshd[1996]: pam_unix(sshd:session): session opened for user volumio by (uid=0)
Jul 22 20:18:52 volumio systemd[1]: Created slice User Slice of UID 1000.
Jul 22 20:18:52 volumio systemd[1]: Starting User Runtime Directory /run/user/1000...
Jul 22 20:18:52 volumio systemd-logind[712]: New session 1 of user volumio.
Jul 22 20:18:52 volumio systemd[1]: Started User Runtime Directory /run/user/1000.
Jul 22 20:18:52 volumio systemd[1]: Starting User Manager for UID 1000...
Jul 22 20:18:52 volumio systemd[2009]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
Jul 22 20:18:52 volumio systemd[2009]: Listening on GnuPG network certificate management daemon.
Jul 22 20:18:52 volumio systemd[2009]: Starting D-Bus User Message Bus Socket.
Jul 22 20:18:52 volumio systemd[2009]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jul 22 20:18:52 volumio systemd[2009]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Jul 22 20:18:52 volumio systemd[2009]: Listening on Sound System.
Jul 22 20:18:52 volumio systemd[2009]: Reached target Paths.
Jul 22 20:18:52 volumio systemd[2009]: Reached target Timers.
Jul 22 20:18:52 volumio systemd[2009]: Listening on GnuPG cryptographic agent and passphrase cache.
Jul 22 20:18:52 volumio systemd[2009]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Jul 22 20:18:52 volumio systemd[2009]: Listening on D-Bus User Message Bus Socket.
Jul 22 20:18:52 volumio systemd[2009]: Reached target Sockets.
Jul 22 20:18:52 volumio systemd[2009]: Reached target Basic System.
Jul 22 20:18:52 volumio systemd[2009]: Starting Music Player Daemon...
Jul 22 20:18:52 volumio systemd[1]: Started User Manager for UID 1000.
Jul 22 20:18:52 volumio systemd[1]: Started Session 1 of user volumio.
Jul 22 20:18:52 volumio mpd[2020]: exception: failed to open log file "/var/log/mpd.log" (config line 8): Permission denied
Jul 22 20:18:52 volumio systemd[2009]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Jul 22 20:18:52 volumio systemd[2009]: mpd.service: Failed with result 'exit-code'.
Jul 22 20:18:52 volumio systemd[2009]: Failed to start Music Player Daemon.
Jul 22 20:18:52 volumio systemd[2009]: Reached target Default.
Jul 22 20:18:52 volumio systemd[2009]: Startup finished in 875ms.
Jul 22 20:19:02 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:19:02 volumio volumio[931]: info: CURURI: music-library/USB/music/Gerber_Raspberry_5_car_ssd_2.zip
Jul 22 20:19:02 volumio volumio[931]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jul 22 20:19:02 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:19:04 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:19:04 volumio volumio[931]: info: CURURI: music-library/USB/music/System Volume Information
Jul 22 20:19:04 volumio volumio[931]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jul 22 20:19:04 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:19:09 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:19:09 volumio volumio[931]: info: CURURI: music-library/USB/music
Jul 22 20:19:09 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:19:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 20:19:10 volumio volumio[931]: info: CURURI: music-library/USB/music/惠威试音碟 (人声篇)
Jul 22 20:19:10 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/03.ONE I LOVE.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/04.往事如昔.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/05.夜色.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/06.情人的眼泪.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/07.月亮代表我的心.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/08.眼神骗不过.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/09.风继续吹.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/10.挥着翅膀的女孩.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/11.泪海.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/12.相思河畔.wav
Jul 22 20:19:10 volumio volumio[931]: info: Preloading song: music-library/USB/music/惠威试音碟 (人声篇)/13.天空.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F01.%E6%9C%88%E5%85%89%E5%B0%8F%E5%A4%9C%E6%9B%B2.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F02.%E5%88%9D%E6%AC%A1%E5%B0%9D%E5%88%B0%E5%AF%82%E5%AF%9E.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/03.ONE I LOVE.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F03.ONE%20I%20LOVE.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/03.ONE I LOVE.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/04.往事如昔.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F04.%E5%BE%80%E4%BA%8B%E5%A6%82%E6%98%94.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/04.往事如昔.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/05.夜色.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F05.%E5%A4%9C%E8%89%B2.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/05.夜色.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/06.情人的眼泪.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F06.%E6%83%85%E4%BA%BA%E7%9A%84%E7%9C%BC%E6%B3%AA.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/06.情人的眼泪.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/07.月亮代表我的心.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F07.%E6%9C%88%E4%BA%AE%E4%BB%A3%E8%A1%A8%E6%88%91%E7%9A%84%E5%BF%83.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/07.月亮代表我的心.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/08.眼神骗不过.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F08.%E7%9C%BC%E7%A5%9E%E9%AA%97%E4%B8%8D%E8%BF%87.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/08.眼神骗不过.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/09.风继续吹.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F09.%E9%A3%8E%E7%BB%A7%E7%BB%AD%E5%90%B9.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/09.风继续吹.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/10.挥着翅膀的女孩.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F10.%E6%8C%A5%E7%9D%80%E7%BF%85%E8%86%80%E7%9A%84%E5%A5%B3%E5%AD%A9.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/10.挥着翅膀的女孩.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/11.泪海.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F11.%E6%B3%AA%E6%B5%B7.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/11.泪海.wav
Jul 22 20:19:10 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/12.相思河畔.wav in service mpd
Jul 22 20:19:10 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F12.%E7%9B%B8%E6%80%9D%E6%B2%B3%E7%95%94.wav&metadata=false
Jul 22 20:19:10 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/12.相思河畔.wav
Jul 22 20:19:11 volumio volumio[931]: info: Exploding uri music-library/USB/music/惠威试音碟 (人声篇)/13.天空.wav in service mpd
Jul 22 20:19:11 volumio volumio[931]: info: ALBUMART /albumart?cacheid=71&web=//extralarge&path=%2Fmnt%2FUSB%2Fmusic%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20(%E4%BA%BA%E5%A3%B0%E7%AF%87)%2F13.%E5%A4%A9%E7%A9%BA.wav&metadata=false
Jul 22 20:19:11 volumio volumio[931]: info: URI /mnt/USB/music/惠威试音碟 (人声篇)/13.天空.wav
Jul 22 20:19:11 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::ClearQueue
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::stop
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::stPlaybackTimer
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::updateTrackBlock
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrackBlock
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::serviceStop
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::serviceStop
Jul 22 20:19:11 volumio volumio[931]: info: ControllerMpd::stop
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand stop
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::clearPlayQueue
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::saveQueue
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::volumioPushQueue
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::addQueueItems
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::addQueueItems
Jul 22 20:19:11 volumio volumio[931]: info: Preload queue cleared
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/03.ONE I LOVE.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/03.ONE I LOVE.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/04.往事如昔.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/04.往事如昔.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/05.夜色.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/05.夜色.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/06.情人的眼泪.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/06.情人的眼泪.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/07.月亮代表我的心.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/07.月亮代表我的心.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/08.眼神骗不过.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/08.眼神骗不过.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/09.风继续吹.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/09.风继续吹.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/10.挥着翅膀的女孩.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/10.挥着翅膀的女孩.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/11.泪海.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/11.泪海.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/12.相思河畔.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/12.相思河畔.wav
Jul 22 20:19:11 volumio volumio[931]: info: Adding Item to queue: music-library/USB/music/惠威试音碟 (人声篇)/13.天空.wav
Jul 22 20:19:11 volumio volumio[931]: info: Using cached record of: music-library/USB/music/惠威试音碟 (人声篇)/13.天空.wav
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::volumioPushQueue
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::saveQueue
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::updateTrackBlock
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrackBlock
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::volumioPlay
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::play index 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::stop
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::play index undefined
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::startPlaybackTimer
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::clearAddPlayTracks USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand stop
Jul 22 20:19:11 volumio volumio[931]: info:
Jul 22 20:19:11 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand stop took 62 milliseconds
Jul 22 20:19:11 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand stop took 21 milliseconds
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand clear
Jul 22 20:19:11 volumio volumio[931]: info:
Jul 22 20:19:11 volumio volumio[931]: ---------------------------- MPD announces system playlist update
Jul 22 20:19:11 volumio volumio[931]: info: Ignoring MPD Status Update
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand status took 7 milliseconds
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand clear took 6 milliseconds
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand add "USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav"
Jul 22 20:19:11 volumio volumio[931]: error: updateQueue error: null
Jul 22 20:19:11 volumio volumio[931]: info:
Jul 22 20:19:11 volumio volumio[931]: ---------------------------- MPD announces system playlist update
Jul 22 20:19:11 volumio volumio[931]: info: Ignoring MPD Status Update
Jul 22 20:19:11 volumio volumio[931]: info: ------------------------------ 7ms
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand add "USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav" took 4 milliseconds
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand play
Jul 22 20:19:11 volumio volumio[931]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 22 20:19:11 volumio volumio[931]: info: ------------------------------ 17ms
Jul 22 20:19:11 volumio volumio[931]: info: ------------------------------ 11ms
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand play took 9 milliseconds
Jul 22 20:19:11 volumio volumio[931]: info:
Jul 22 20:19:11 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:19:11 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:19:11 volumio volumio[931]: info:
Jul 22 20:19:11 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:19:11 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand status took 7 milliseconds
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand status took 2 milliseconds
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:19:11 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.月光小夜曲.wav","artist":null,"album":null,"uri":"USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav","trackType":"wav"}
Jul 22 20:19:11 volumio volumio[931]: verbose: CURRENT POSITION 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop
Jul 22 20:19:11 volumio volumio[931]: info: ------------------------------ 13ms
Jul 22 20:19:11 volumio volumio[931]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 22 20:19:11 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:19:11 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":250,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.月光小夜曲.wav","artist":null,"album":null,"uri":"USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav","trackType":"wav"}
Jul 22 20:19:11 volumio volumio[931]: verbose: CURRENT POSITION 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus play
Jul 22 20:19:11 volumio volumio[931]: info: Received an update from plugin. extracting info from payload
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:11 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:11 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:11 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:11 volumio volumio[931]: info: ------------------------------ 35ms
Jul 22 20:19:13 volumio volumio[931]: info: CoreCommandRouter::volumioGetState
Jul 22 20:19:13 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::volumioNext
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::next
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::stop
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::stPlaybackTimer
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::updateTrackBlock
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrackBlock
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::serviceStop
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 0
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::serviceStop
Jul 22 20:19:14 volumio volumio[931]: info: ControllerMpd::stop
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand stop
Jul 22 20:19:14 volumio volumio[931]: info:
Jul 22 20:19:14 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand stop took 25 milliseconds
Jul 22 20:19:14 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::play index undefined
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::startPlaybackTimer
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::clearAddPlayTracks USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand stop
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::updateTrackBlock
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrackBlock
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand status took 4 milliseconds
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand stop took 2 milliseconds
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand clear
Jul 22 20:19:14 volumio volumio[931]: info:
Jul 22 20:19:14 volumio volumio[931]: ---------------------------- MPD announces system playlist update
Jul 22 20:19:14 volumio volumio[931]: info: Ignoring MPD Status Update
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand clear took 2 milliseconds
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand add "USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav"
Jul 22 20:19:14 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.月光小夜曲.wav","artist":null,"album":null,"uri":"USB/music/惠威试音碟 (人声篇)/01.月光小夜曲.wav","trackType":"wav"}
Jul 22 20:19:14 volumio volumio[931]: verbose: CURRENT POSITION 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::syncState stateService stop
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:14 volumio volumio[931]: info: No code
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:14 volumio volumio[931]: info: ------------------------------ 43ms
Jul 22 20:19:14 volumio volumio[931]: error: updateQueue error: null
Jul 22 20:19:14 volumio volumio[931]: info:
Jul 22 20:19:14 volumio volumio[931]: ---------------------------- MPD announces system playlist update
Jul 22 20:19:14 volumio volumio[931]: info: Ignoring MPD Status Update
Jul 22 20:19:14 volumio volumio[931]: info: ------------------------------ 38ms
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand add "USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav" took 36 milliseconds
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand play
Jul 22 20:19:14 volumio volumio[931]: info:
Jul 22 20:19:14 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:19:14 volumio volumio[931]: info: ------------------------------ 14ms
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand play took 12 milliseconds
Jul 22 20:19:14 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:19:14 volumio volumio[931]: info:
Jul 22 20:19:14 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:19:14 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand status took 5 milliseconds
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand status took 3 milliseconds
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:19:14 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.初次尝到寂寞.wav","artist":null,"album":null,"uri":"USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav","trackType":"wav"}
Jul 22 20:19:14 volumio volumio[931]: verbose: CURRENT POSITION 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop
Jul 22 20:19:14 volumio volumio[931]: info: ------------------------------ 13ms
Jul 22 20:19:14 volumio volumio[931]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 22 20:19:14 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:19:14 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.初次尝到寂寞.wav","artist":null,"album":null,"uri":"USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav","trackType":"wav"}
Jul 22 20:19:14 volumio volumio[931]: verbose: CURRENT POSITION 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::syncState stateService play
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus play
Jul 22 20:19:14 volumio volumio[931]: info: Received an update from plugin. extracting info from payload
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:14 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:14 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:14 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:14 volumio volumio[931]: info: ------------------------------ 46ms
Jul 22 20:19:15 volumio volumio[931]: info: CoreCommandRouter::volumioPause
Jul 22 20:19:15 volumio volumio[931]: info: CoreStateMachine::pause
Jul 22 20:19:15 volumio volumio[931]: info: CoreStateMachine::stPlaybackTimer
Jul 22 20:19:15 volumio volumio[931]: info: CoreStateMachine::servicePause
Jul 22 20:19:15 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:15 volumio volumio[931]: info: CoreCommandRouter::servicePause
Jul 22 20:19:15 volumio volumio[931]: info: ControllerMpd::pause
Jul 22 20:19:15 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand pause
Jul 22 20:19:15 volumio volumio[931]: info: sendMpdCommand pause took 1 milliseconds
Jul 22 20:19:15 volumio volumio[931]: info:
Jul 22 20:19:15 volumio volumio[931]: ---------------------------- MPD announces state update: player
Jul 22 20:19:15 volumio volumio[931]: info: ControllerMpd::getState
Jul 22 20:19:15 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 20:19:15 volumio volumio[931]: info: sendMpdCommand status took 0 milliseconds
Jul 22 20:19:15 volumio volumio[931]: verbose: ControllerMpd::parseState
Jul 22 20:19:15 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 20:19:15 volumio volumio[931]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 22 20:19:15 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo
Jul 22 20:19:15 volumio volumio[931]: info: ControllerMpd::pushState
Jul 22 20:19:15 volumio volumio[931]: info: CoreCommandRouter::servicePushState
Jul 22 20:19:15 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:15 volumio volumio[931]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1457,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.初次尝到寂寞.wav","artist":null,"album":null,"uri":"USB/music/惠威试音碟 (人声篇)/02.初次尝到寂寞.wav","trackType":"wav"}
Jul 22 20:19:15 volumio volumio[931]: verbose: CURRENT POSITION 1
Jul 22 20:19:15 volumio volumio[931]: info: CoreStateMachine::syncState stateService pause
Jul 22 20:19:15 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus pause
Jul 22 20:19:15 volumio volumio[931]: info: CoreStateMachine::pushState
Jul 22 20:19:15 volumio volumio[931]: info: CorePlayQueue::getTrack 1
Jul 22 20:19:15 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 20:19:15 volumio volumio[931]: info: CoreCommandRouter::volumioPushState
Jul 22 20:19:15 volumio volumio[931]: info: CoreStateMachine::stPlaybackTimer
Jul 22 20:19:15 volumio volumio[931]: info: ------------------------------ 15ms
Jul 22 20:19:15 volumio volumio[931]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 20:19:15 volumio volumio[931]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Jul 22 20:19:15 volumio volumio[931]: at Object.readdirSync (fs.js:1048:3)
Jul 22 20:19:15 volumio volumio[931]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Jul 22 20:19:15 volumio volumio[931]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Jul 22 20:19:15 volumio volumio[931]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Jul 22 20:19:15 volumio volumio[931]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Jul 22 20:19:15 volumio volumio[931]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Jul 22 20:19:15 volumio volumio[931]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Jul 22 20:19:15 volumio volumio[931]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Jul 22 20:19:15 volumio volumio[931]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Jul 22 20:19:15 volumio volumio[931]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Jul 22 20:19:15 volumio volumio[931]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Jul 22 20:19:15 volumio volumio[931]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Jul 22 20:19:15 volumio volumio[931]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Jul 22 20:19:15 volumio volumio[931]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Jul 22 20:19:15 volumio volumio[931]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Jul 22 20:19:15 volumio volumio[931]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Jul 22 20:19:15 volumio volumio[931]: errno: -20,
Jul 22 20:19:15 volumio volumio[931]: syscall: 'scandir',
Jul 22 20:19:15 volumio volumio[931]: code: 'ENOTDIR',
Jul 22 20:19:15 volumio volumio[931]: path: '/tmp/peppyrunning'
Jul 22 20:19:15 volumio volumio[931]: }
Jul 22 20:19:15 volumio volumio[931]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 20:19:15 volumio sudo[2157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 20:18
Jul 22 20:19:15 volumio sudo[2157]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"