Jan 09 19:47:05 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:05 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:15 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:15 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:15 volumio volumio[15036]: info: Listing playlists
Jan 09 19:47:15 volumio volumio[15036]: info: Listing playlists
Jan 09 19:47:16 volumio volumio[15036]: info:
Jan 09 19:47:16 volumio volumio[15036]: ---------------------------- Client requests Volumio play
Jan 09 19:47:16 volumio volumio[15036]: info: CoreCommandRouter::volumioPlay
Jan 09 19:47:16 volumio volumio[15036]: info: CoreStateMachine::play index undefined
Jan 09 19:47:16 volumio volumio[15036]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 19:47:16 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:16 volumio volumio[15036]: info: CoreStateMachine::startPlaybackTimer
Jan 09 19:47:16 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:16 volumio volumio[15036]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac
Jan 09 19:47:16 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 19:47:16 volumio volumio[15036]: info: sendMpdCommand stop took 6 milliseconds
Jan 09 19:47:16 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 19:47:16 volumio volumio[15036]: info:
Jan 09 19:47:16 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:16 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:16 volumio volumio[15036]: info: sendMpdCommand clear took 4 milliseconds
Jan 09 19:47:16 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac"
Jan 09 19:47:16 volumio volumio[15036]: info:
Jan 09 19:47:16 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:16 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:16 volumio volumio[15036]: info:
Jan 09 19:47:16 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:16 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:16 volumio volumio[15036]: error: updateQueue error: null
Jan 09 19:47:16 volumio volumio[15036]: info:
Jan 09 19:47:16 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:16 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:16 volumio volumio[15036]: info: ------------------------------ 16ms
Jan 09 19:47:16 volumio volumio[15036]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac" took 12 milliseconds
Jan 09 19:47:16 volumio volumio[15036]: info: ------------------------------ 10ms
Jan 09 19:47:16 volumio volumio[15036]: info: ------------------------------ 10ms
Jan 09 19:47:16 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 19:47:16 volumio volumio[15036]: info:
Jan 09 19:47:16 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:16 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:16 volumio volumio[15036]: info:
Jan 09 19:47:16 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:16 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:16 volumio volumio[15036]: info: ------------------------------ 18ms
Jan 09 19:47:16 volumio volumio[15036]: info: sendMpdCommand play took 11 milliseconds
Jan 09 19:47:16 volumio volumio[15036]: info: ------------------------------ 10ms
Jan 09 19:47:16 volumio volumio[15036]: info: ------------------------------ 8ms
Jan 09 19:47:16 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:16 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info:
Jan 09 19:47:17 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:17 volumio volumio[15036]: info:
Jan 09 19:47:17 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:17 volumio volumio[15036]: info:
Jan 09 19:47:17 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand status took 15 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:17 volumio volumio[15036]: info:
Jan 09 19:47:17 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:17 volumio volumio[15036]: info:
Jan 09 19:47:17 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand status took 27 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand status took 25 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand status took 9 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"901 Kbps","isStreaming":false,"title":"Honey B","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac","trackType":"flac"}
Jan 09 19:47:17 volumio volumio[15036]: verbose: CURRENT POSITION 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 19:47:17 volumio volumio[15036]: info: ------------------------------ 57ms
Jan 09 19:47:17 volumio volumio[15036]: info:
Jan 09 19:47:17 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand status took 29 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 25 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 24 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 19 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand status took 6 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":664,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1037 Kbps","isStreaming":false,"title":"Honey B","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac","trackType":"flac"}
Jan 09 19:47:17 volumio volumio[15036]: verbose: CURRENT POSITION 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:17 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":664,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1037 Kbps","isStreaming":false,"title":"Honey B","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac","trackType":"flac"}
Jan 09 19:47:17 volumio volumio[15036]: verbose: CURRENT POSITION 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:17 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"883 Kbps","isStreaming":false,"title":"Honey B","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac","trackType":"flac"}
Jan 09 19:47:17 volumio volumio[15036]: verbose: CURRENT POSITION 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:17 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: ------------------------------ 150ms
Jan 09 19:47:17 volumio volumio[15036]: info: ------------------------------ 148ms
Jan 09 19:47:17 volumio volumio[15036]: info: ------------------------------ 130ms
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 93 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 89 milliseconds
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:17 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"883 Kbps","isStreaming":false,"title":"Honey B","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac","trackType":"flac"}
Jan 09 19:47:17 volumio volumio[15036]: verbose: CURRENT POSITION 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:17 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"883 Kbps","isStreaming":false,"title":"Honey B","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac","trackType":"flac"}
Jan 09 19:47:17 volumio volumio[15036]: verbose: CURRENT POSITION 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:17 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:17 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:17 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:17 volumio volumio[15036]: info: ------------------------------ 176ms
Jan 09 19:47:17 volumio volumio[15036]: info: ------------------------------ 147ms
Jan 09 19:47:18 volumio volumio[15036]: info:
Jan 09 19:47:18 volumio volumio[15036]: ---------------------------- Client requests Volumio play
Jan 09 19:47:18 volumio volumio[15036]: info: CoreCommandRouter::volumioPlay
Jan 09 19:47:18 volumio volumio[15036]: info: CoreStateMachine::play index undefined
Jan 09 19:47:18 volumio volumio[15036]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 19:47:18 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:19 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:19 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:23 volumio nmbd[1016]: [2026/01/09 19:47:23.951257, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jan 09 19:47:23 volumio nmbd[1016]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.31.86 for name WORKGROUP<1d>.
Jan 09 19:47:23 volumio nmbd[1016]: This response was from IP 192.168.31.87, reporting an IP address of 192.168.31.87.
Jan 09 19:47:25 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:25 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- Client requests Volumio next
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::volumioNext
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::next
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::stop
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::stPlaybackTimer
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::updateTrackBlock
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrackBlock
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::serviceStop
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 0
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::serviceStop
Jan 09 19:47:30 volumio volumio[15036]: info: ControllerMpd::stop
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand stop took 13 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::play index undefined
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::startPlaybackTimer
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::updateTrackBlock
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrackBlock
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:30 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:30 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand status took 12 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand stop took 8 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand status took 5 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand status took 3 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:30 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand clear took 10 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac"
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:30 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:30 volumio volumio[15036]: 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":"Honey B","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - Honey B.flac","trackType":"flac"}
Jan 09 19:47:30 volumio volumio[15036]: verbose: CURRENT POSITION 14
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::syncState stateService stop
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:30 volumio volumio[15036]: info: No code
Jan 09 19:47:30 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:30 volumio volumio[15036]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 19:47:30 volumio volumio[15036]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 57ms
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 49ms
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 48ms
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:30 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:30 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:30 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:30 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:30 volumio volumio[15036]: error: updateQueue error: null
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:30 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 45ms
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac" took 41 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 12ms
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 10ms
Jan 09 19:47:30 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:30 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:30 volumio volumio[15036]: info:
Jan 09 19:47:30 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:30 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 25ms
Jan 09 19:47:30 volumio volumio[15036]: info: sendMpdCommand play took 22 milliseconds
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 22ms
Jan 09 19:47:30 volumio volumio[15036]: info: ------------------------------ 21ms
Jan 09 19:47:30 volumio volumio[15036]: info: Listing playlists
Jan 09 19:47:30 volumio volumio[15036]: info: Listing playlists
Jan 09 19:47:31 volumio volumio[15036]: info:
Jan 09 19:47:31 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:31 volumio volumio[15036]: info:
Jan 09 19:47:31 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:31 volumio volumio[15036]: info:
Jan 09 19:47:31 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand status took 15 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:31 volumio volumio[15036]: info:
Jan 09 19:47:31 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:31 volumio volumio[15036]: info:
Jan 09 19:47:31 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand status took 27 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand status took 25 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand status took 9 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"暗戀妳","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac","trackType":"flac"}
Jan 09 19:47:31 volumio volumio[15036]: verbose: CURRENT POSITION 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 19:47:31 volumio volumio[15036]: info: ------------------------------ 49ms
Jan 09 19:47:31 volumio volumio[15036]: info:
Jan 09 19:47:31 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand status took 26 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 21 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 19 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand status took 6 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"641 Kbps","isStreaming":false,"title":"暗戀妳","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac","trackType":"flac"}
Jan 09 19:47:31 volumio volumio[15036]: verbose: CURRENT POSITION 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:31 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"641 Kbps","isStreaming":false,"title":"暗戀妳","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac","trackType":"flac"}
Jan 09 19:47:31 volumio volumio[15036]: verbose: CURRENT POSITION 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:31 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"641 Kbps","isStreaming":false,"title":"暗戀妳","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac","trackType":"flac"}
Jan 09 19:47:31 volumio volumio[15036]: verbose: CURRENT POSITION 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:31 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: ------------------------------ 144ms
Jan 09 19:47:31 volumio volumio[15036]: info: ------------------------------ 143ms
Jan 09 19:47:31 volumio volumio[15036]: info: ------------------------------ 129ms
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 91 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 87 milliseconds
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:31 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"641 Kbps","isStreaming":false,"title":"暗戀妳","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac","trackType":"flac"}
Jan 09 19:47:31 volumio volumio[15036]: verbose: CURRENT POSITION 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:31 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":275,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"641 Kbps","isStreaming":false,"title":"暗戀妳","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac","trackType":"flac"}
Jan 09 19:47:31 volumio volumio[15036]: verbose: CURRENT POSITION 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:31 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:31 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:31 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:31 volumio volumio[15036]: info: ------------------------------ 161ms
Jan 09 19:47:31 volumio volumio[15036]: info: ------------------------------ 139ms
Jan 09 19:47:35 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:35 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:37 volumio volumio[15036]: info:
Jan 09 19:47:37 volumio volumio[15036]: ---------------------------- Client requests Volumio next
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::volumioNext
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::next
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::stop
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::stPlaybackTimer
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::updateTrackBlock
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrackBlock
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::serviceStop
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 14
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::serviceStop
Jan 09 19:47:37 volumio volumio[15036]: info: ControllerMpd::stop
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 19:47:37 volumio volumio[15036]: info:
Jan 09 19:47:37 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand stop took 16 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::play index undefined
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::startPlaybackTimer
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::clearAddPlayTracks NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand stop
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::updateTrackBlock
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrackBlock
Jan 09 19:47:37 volumio volumio[15036]: info:
Jan 09 19:47:37 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:37 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:37 volumio volumio[15036]: info:
Jan 09 19:47:37 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:37 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand status took 13 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand stop took 10 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand status took 6 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand status took 4 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand clear
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:37 volumio volumio[15036]: info:
Jan 09 19:47:37 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:37 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand clear took 8 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand add "NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac"
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:37 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:37 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:37 volumio volumio[15036]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"暗戀妳","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 暗戀妳.flac","trackType":"flac"}
Jan 09 19:47:37 volumio volumio[15036]: verbose: CURRENT POSITION 12
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::syncState stateService stop
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:37 volumio volumio[15036]: info: No code
Jan 09 19:47:37 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:37 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:37 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:37 volumio volumio[15036]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 19:47:37 volumio volumio[15036]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 63ms
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 55ms
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 52ms
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:38 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:38 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:38 volumio volumio[15036]: error: updateQueue error: null
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:38 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 43ms
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand add "NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac" took 39 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 6ms
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 4ms
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand play
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:38 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces system playlist update
Jan 09 19:47:38 volumio volumio[15036]: info: Ignoring MPD Status Update
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 26ms
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand play took 24 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 23ms
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 21ms
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand status took 23 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand status took 33 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand status took 32 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand status took 5 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我等到花兒也謝了","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac","trackType":"flac"}
Jan 09 19:47:38 volumio volumio[15036]: verbose: CURRENT POSITION 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus stop
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 47ms
Jan 09 19:47:38 volumio volumio[15036]: info:
Jan 09 19:47:38 volumio volumio[15036]: ---------------------------- MPD announces state update: player
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::getState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand status
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand status took 13 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand status took 5 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseState
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我等到花兒也謝了","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac","trackType":"flac"}
Jan 09 19:47:38 volumio volumio[15036]: verbose: CURRENT POSITION 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:38 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我等到花兒也謝了","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac","trackType":"flac"}
Jan 09 19:47:38 volumio volumio[15036]: verbose: CURRENT POSITION 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:38 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"440 Kbps","isStreaming":false,"title":"我等到花兒也謝了","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac","trackType":"flac"}
Jan 09 19:47:38 volumio volumio[15036]: verbose: CURRENT POSITION 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:38 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 121ms
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 120ms
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 92ms
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 72 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: info: sendMpdCommand playlistinfo took 71 milliseconds
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:38 volumio volumio[15036]: verbose: ControllerMpd::parseTrackInfo
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"440 Kbps","isStreaming":false,"title":"我等到花兒也謝了","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac","trackType":"flac"}
Jan 09 19:47:38 volumio volumio[15036]: verbose: CURRENT POSITION 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:38 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: ControllerMpd::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::servicePushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"440 Kbps","isStreaming":false,"title":"我等到花兒也謝了","artist":"张学友","album":null,"uri":"NAS/4800/#recycle/music/yinyue/张学友 - 我等到花兒也謝了.flac","trackType":"flac"}
Jan 09 19:47:38 volumio volumio[15036]: verbose: CURRENT POSITION 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState stateService play
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::syncState currentStatus play
Jan 09 19:47:38 volumio volumio[15036]: info: Received an update from plugin. extracting info from payload
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: CoreStateMachine::pushState
Jan 09 19:47:38 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:38 volumio volumio[15036]: info: CoreCommandRouter::volumioPushState
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 126ms
Jan 09 19:47:38 volumio volumio[15036]: info: ------------------------------ 115ms
Jan 09 19:47:45 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:45 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:55 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:47:55 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:47:55 volumio volumio[15036]: info: Listing playlists
Jan 09 19:47:55 volumio volumio[15036]: info: Listing playlists
Jan 09 19:48:05 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:48:05 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:48:15 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:48:15 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:48:15 volumio volumio[15036]: info: Listing playlists
Jan 09 19:48:15 volumio volumio[15036]: info: Listing playlists
Jan 09 19:48:25 volumio volumio[15036]: info: CoreCommandRouter::volumioGetState
Jan 09 19:48:25 volumio volumio[15036]: info: CorePlayQueue::getTrack 12
Jan 09 19:48:32 volumio volumio[15036]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 09 19:48:32 volumio volumio[15036]: Error: connect ETIMEDOUT 199.59.148.15:80
Jan 09 19:48:32 volumio volumio[15036]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Jan 09 19:48:32 volumio volumio[15036]: errno: -110,
Jan 09 19:48:32 volumio volumio[15036]: code: 'ETIMEDOUT',
Jan 09 19:48:32 volumio volumio[15036]: syscall: 'connect',
Jan 09 19:48:32 volumio volumio[15036]: address: '199.59.148.15',
Jan 09 19:48:32 volumio volumio[15036]: port: 80
Jan 09 19:48:32 volumio volumio[15036]: }
Jan 09 19:48:32 volumio volumio[15036]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 09 19:48:33 volumio sudo[15755]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 19:47'
Jan 09 19:48:33 volumio sudo[15755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"