-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2025-03-16 23:18:13 CST. --
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 16 23:17:00 volumio volumio[952]: info: Discovery: Getting this device information
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:17:00 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 16 23:17:00 volumio volumio[952]: verbose: New Socket.io Connection to 192.168.100.221:3000 from 192.168.100.13 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 16 23:17:00 volumio volumio[952]: info: Discovery: Getting this device information
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:17:00 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:00 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 16 23:17:00 volumio volumio[952]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sol%20Gabetta/Mendelssohn/9fd4dd9f-7c72-4fd7-85d0-75c282c9342c.jpg'
Mar 16 23:17:01 volumio volumio[952]: info:
Mar 16 23:17:01 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:01 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:01 volumio volumio[952]: info:
Mar 16 23:17:01 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:01 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:01 volumio volumio[952]: info:
Mar 16 23:17:01 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:01 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:01 volumio volumio[952]: info:
Mar 16 23:17:01 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:01 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:01 volumio volumio[952]: info:
Mar 16 23:17:01 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:01 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:01 volumio volumio[952]: info:
Mar 16 23:17:01 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:01 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:01 volumio volumio[952]: info: ------------------------------ 6ms
Mar 16 23:17:01 volumio volumio[952]: info: sendMpdCommand status took 5 milliseconds
Mar 16 23:17:01 volumio volumio[952]: info: ------------------------------ 4ms
Mar 16 23:17:01 volumio volumio[952]: info: sendMpdCommand status took 3 milliseconds
Mar 16 23:17:01 volumio volumio[952]: info: ------------------------------ 3ms
Mar 16 23:17:01 volumio volumio[952]: info: sendMpdCommand status took 3 milliseconds
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:01 volumio volumio[952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 16 23:17:01 volumio volumio[952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 16 23:17:01 volumio volumio[952]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:01 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:01 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2487 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:01 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:01 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:01 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2487 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:01 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:01 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:01 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2487 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:01 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:01 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:17:01 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:01 volumio volumio[952]: info: ------------------------------ 54ms
Mar 16 23:17:01 volumio volumio[952]: info: ------------------------------ 54ms
Mar 16 23:17:01 volumio volumio[952]: info: ------------------------------ 52ms
Mar 16 23:17:01 volumio volumio[952]: info: CoreStateMachine::startPlaybackTimer
Mar 16 23:17:01 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:02 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:02 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:02 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:02 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:02 volumio volumio[952]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sol%20Gabetta/Mendelssohn/9fd4dd9f-7c72-4fd7-85d0-75c282c9342c.jpg'
Mar 16 23:17:02 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 16 23:17:02 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 16 23:17:02 volumio volumio[952]: info: Discovery: Getting this device information
Mar 16 23:17:02 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:17:02 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:02 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 16 23:17:03 volumio volumio[952]: verbose: New Socket.io Connection to 192.168.100.221 from 192.168.100.13 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:17:03 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 16 23:17:03 volumio volumio[952]: info: Received Get System Info
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 16 23:17:03 volumio volumio[952]: info: Discovery: Getting this device information
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:17:03 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:17:03 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:03 volumio volumio[952]: info: Listing playlists
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::volumioGetQueue
Mar 16 23:17:03 volumio volumio[952]: info: CoreStateMachine::getQueue
Mar 16 23:17:03 volumio volumio[952]: info: CorePlayQueue::getQueue
Mar 16 23:17:03 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::volumioPause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::pause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::stPlaybackTimer
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::servicePause
Mar 16 23:17:07 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::servicePause
Mar 16 23:17:07 volumio volumio[952]: info: ControllerMpd::pause
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand pause
Mar 16 23:17:07 volumio volumio[952]: info: sendMpdCommand pause took 2 milliseconds
Mar 16 23:17:07 volumio volumio[952]: info:
Mar 16 23:17:07 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:07 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:07 volumio volumio[952]: info:
Mar 16 23:17:07 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:07 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:07 volumio volumio[952]: info:
Mar 16 23:17:07 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:07 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:07 volumio volumio[952]: info: sendMpdCommand status took 4 milliseconds
Mar 16 23:17:07 volumio volumio[952]: info: sendMpdCommand status took 3 milliseconds
Mar 16 23:17:07 volumio volumio[952]: info: sendMpdCommand status took 2 milliseconds
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:07 volumio volumio[952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 16 23:17:07 volumio volumio[952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 16 23:17:07 volumio volumio[952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:07 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:07 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:07 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:07 volumio volumio[952]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6305,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2551 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:07 volumio volumio[952]: verbose: CURRENT POSITION 1
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::syncState stateService pause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus pause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:07 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::stPlaybackTimer
Mar 16 23:17:07 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:07 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:07 volumio volumio[952]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6305,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2551 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:07 volumio volumio[952]: verbose: CURRENT POSITION 1
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::syncState stateService pause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus pause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:07 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::stPlaybackTimer
Mar 16 23:17:07 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:07 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:07 volumio volumio[952]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":6305,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2551 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:07 volumio volumio[952]: verbose: CURRENT POSITION 1
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::syncState stateService pause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus pause
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:07 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:07 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:07 volumio volumio[952]: info: CoreStateMachine::stPlaybackTimer
Mar 16 23:17:07 volumio volumio[952]: info: ------------------------------ 43ms
Mar 16 23:17:07 volumio volumio[952]: info: ------------------------------ 41ms
Mar 16 23:17:07 volumio volumio[952]: info: ------------------------------ 41ms
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::volumioPlay
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::play index undefined
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::startPlaybackTimer
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: info: ControllerMpd::resume
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand play
Mar 16 23:17:16 volumio volumio[952]: info: sendMpdCommand play took 4 milliseconds
Mar 16 23:17:16 volumio volumio[952]: info:
Mar 16 23:17:16 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:16 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:16 volumio volumio[952]: info:
Mar 16 23:17:16 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:16 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:16 volumio volumio[952]: info:
Mar 16 23:17:16 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:16 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:16 volumio volumio[952]: info: sendMpdCommand status took 7 milliseconds
Mar 16 23:17:16 volumio volumio[952]: info: sendMpdCommand status took 4 milliseconds
Mar 16 23:17:16 volumio volumio[952]: info: sendMpdCommand status took 3 milliseconds
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:16 volumio volumio[952]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 16 23:17:16 volumio volumio[952]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 16 23:17:16 volumio volumio[952]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:16 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:16 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7176,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2561 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:16 volumio volumio[952]: verbose: CURRENT POSITION 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus pause
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:16 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7302,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2516 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:16 volumio volumio[952]: verbose: CURRENT POSITION 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:16 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:16 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7302,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2516 Kbps","isStreaming":false,"title":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:16 volumio volumio[952]: verbose: CURRENT POSITION 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:16 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:16 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:16 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:16 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:16 volumio volumio[952]: info: ------------------------------ 82ms
Mar 16 23:17:16 volumio volumio[952]: info: ------------------------------ 80ms
Mar 16 23:17:16 volumio volumio[952]: info: ------------------------------ 79ms
Mar 16 23:17:19 volumio volumio[952]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sol%20Gabetta/Mendelssohn/9fd4dd9f-7c72-4fd7-85d0-75c282c9342c.jpg'
Mar 16 23:17:19 volumio volumio[952]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 16 23:17:19 volumio volumio[952]: info: Retrying Login Due to Network Error
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioNext
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::next
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::stPlaybackTimer
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::updateTrackBlock
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrackBlock
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::serviceStop
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 1
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::serviceStop
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::stop
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand stop
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand stop took 9 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::play index undefined
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::startPlaybackTimer
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::clearAddPlayTracks USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::updateTrackBlock
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrackBlock
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 2 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand stop took 1 milliseconds
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand clear
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:21 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand clear took 4 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 3 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 2 milliseconds
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand add "USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac"
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: 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":"02 - II. Variation I","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/02 - II. Variation I.flac","trackType":"flac"}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: No code
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: No code
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus stop
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: No code
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 94ms
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 90ms
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 90ms
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:21 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:21 volumio volumio[952]: error: updateQueue error: null
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:21 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 93ms
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand add "USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac" took 91 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 3ms
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand play
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:21 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:21 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 18ms
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand play took 17 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 17ms
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 16ms
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:21 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 8 milliseconds
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 9 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 9ms
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 6 milliseconds
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info:
Mar 16 23:17:21 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand playlistinfo took 7 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 5 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand status took 3 milliseconds
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - III. Variation II","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac","trackType":"flac"}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus stop
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - III. Variation II","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac","trackType":"flac"}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:21 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 - III. Variation II","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac","trackType":"flac"}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:21 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 60ms
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 88ms
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 84ms
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand playlistinfo took 61 milliseconds
Mar 16 23:17:21 volumio volumio[952]: info: sendMpdCommand playlistinfo took 61 milliseconds
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:21 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":225,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2456 Kbps","isStreaming":false,"title":"03 - III. Variation II","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac","trackType":"flac"}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:21 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":293,"duration":30,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2473 Kbps","isStreaming":false,"title":"03 - III. Variation II","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/03 - III. Variation II.flac","trackType":"flac"}
Mar 16 23:17:21 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:21 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:21 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:21 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 117ms
Mar 16 23:17:21 volumio volumio[952]: info: ------------------------------ 116ms
Mar 16 23:17:29 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 16 23:17:29 volumio volumio[952]: info: CURURI: music-library/USB/TU200Pro/DSD
Mar 16 23:17:29 volumio volumio[952]: info: Preload queue cleared
Mar 16 23:17:29 volumio volumio[952]: info: MyVolumio login type: Token
Mar 16 23:17:32 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 16 23:17:32 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 16 23:17:32 volumio volumio[952]: info: Discovery: Getting this device information
Mar 16 23:17:32 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:17:32 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:32 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 16 23:17:38 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 16 23:17:38 volumio volumio[952]: info: CURURI: music-library/USB/TU200Pro/纯音古典
Mar 16 23:17:38 volumio volumio[952]: info: Preload queue cleared
Mar 16 23:17:46 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:46 volumio volumio[952]: info: CorePlayQueue::getTrack 3
Mar 16 23:17:46 volumio volumio[952]: info: Prefetching next song
Mar 16 23:17:46 volumio volumio[952]: info: DOING PREFETCH IN MPD
Mar 16 23:17:46 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand add "USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/04 - IV. Più vivace Variation.flac"
Mar 16 23:17:46 volumio volumio[952]: info:
Mar 16 23:17:46 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:46 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:46 volumio volumio[952]: info: sendMpdCommand add "USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/04 - IV. Più vivace Variation.flac" took 2 milliseconds
Mar 16 23:17:46 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand consume 1
Mar 16 23:17:46 volumio volumio[952]: info:
Mar 16 23:17:46 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:46 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:46 volumio volumio[952]: info:
Mar 16 23:17:46 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:46 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:46 volumio volumio[952]: info: ------------------------------ 5ms
Mar 16 23:17:46 volumio volumio[952]: info: sendMpdCommand consume 1 took 5 milliseconds
Mar 16 23:17:46 volumio volumio[952]: info: ------------------------------ 4ms
Mar 16 23:17:46 volumio volumio[952]: info: ------------------------------ 3ms
Mar 16 23:17:47 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 16 23:17:47 volumio volumio[952]: info: CURURI: music-library/USB/TU200Pro/纯音古典/纯音new age
Mar 16 23:17:47 volumio volumio[952]: info: Preload queue cleared
Mar 16 23:17:50 volumio volumio[952]: info:
Mar 16 23:17:50 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:50 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:50 volumio volumio[952]: info:
Mar 16 23:17:50 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:50 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:50 volumio volumio[952]: info:
Mar 16 23:17:50 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:50 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:50 volumio volumio[952]: info:
Mar 16 23:17:50 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:50 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:50 volumio volumio[952]: info:
Mar 16 23:17:50 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:17:50 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:17:50 volumio volumio[952]: info:
Mar 16 23:17:50 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:17:50 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:17:50 volumio volumio[952]: info: ------------------------------ 10ms
Mar 16 23:17:50 volumio volumio[952]: info: sendMpdCommand status took 7 milliseconds
Mar 16 23:17:50 volumio volumio[952]: info: ------------------------------ 5ms
Mar 16 23:17:50 volumio volumio[952]: info: sendMpdCommand status took 4 milliseconds
Mar 16 23:17:50 volumio volumio[952]: info: ------------------------------ 4ms
Mar 16 23:17:50 volumio volumio[952]: info: sendMpdCommand status took 3 milliseconds
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:17:50 volumio volumio[952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 16 23:17:50 volumio volumio[952]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 16 23:17:50 volumio volumio[952]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:50 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:17:50 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":32,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2730 Kbps","isStreaming":false,"title":"04 - IV. Più vivace Variation","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/04 - IV. Più vivace Variation.flac","trackType":"flac"}
Mar 16 23:17:50 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:50 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:50 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":32,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2730 Kbps","isStreaming":false,"title":"04 - IV. Più vivace Variation","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/04 - IV. Più vivace Variation.flac","trackType":"flac"}
Mar 16 23:17:50 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:50 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:50 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":32,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2730 Kbps","isStreaming":false,"title":"04 - IV. Più vivace Variation","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/04 - IV. Più vivace Variation.flac","trackType":"flac"}
Mar 16 23:17:50 volumio volumio[952]: verbose: CURRENT POSITION 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:17:50 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 2
Mar 16 23:17:50 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:50 volumio volumio[952]: info: ------------------------------ 67ms
Mar 16 23:17:50 volumio volumio[952]: info: ------------------------------ 63ms
Mar 16 23:17:50 volumio volumio[952]: info: ------------------------------ 63ms
Mar 16 23:17:50 volumio volumio[952]: info: CoreStateMachine::startPlaybackTimer
Mar 16 23:17:50 volumio volumio[952]: info: CorePlayQueue::getTrack 3
Mar 16 23:17:51 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:17:51 volumio volumio[952]: info: CorePlayQueue::getTrack 3
Mar 16 23:17:51 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:17:51 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:17:56 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 16 23:17:56 volumio volumio[952]: info: CURURI: music-library/USB/TU200Pro/纯音古典/纯音new age/达人艺典 古筝尚靖雅 筝戏 (24K金碟母盘1:1直刻版)
Mar 16 23:17:56 volumio volumio[952]: info: Preload queue cleared
Mar 16 23:17:59 volumio volumio[952]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 16 23:17:59 volumio volumio[952]: info: Retrying Login Due to Network Error
Mar 16 23:18:02 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 16 23:18:02 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 16 23:18:02 volumio volumio[952]: info: Discovery: Getting this device information
Mar 16 23:18:02 volumio volumio[952]: info: CoreCommandRouter::volumioGetState
Mar 16 23:18:02 volumio volumio[952]: info: CorePlayQueue::getTrack 3
Mar 16 23:18:02 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 16 23:18:09 volumio volumio[952]: info: Preload queue cleared
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::ClearQueue
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::stop
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::stPlaybackTimer
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::updateTrackBlock
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrackBlock
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 3
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::serviceStop
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 3
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::serviceStop
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::stop
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand stop
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::clearPlayQueue
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::saveQueue
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushQueue
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::addQueueItems
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::addQueueItems
Mar 16 23:18:09 volumio volumio[952]: info: Preload queue cleared
Mar 16 23:18:09 volumio volumio[952]: info: Adding Item to queue: music-library/USB/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去
Mar 16 23:18:09 volumio volumio[952]: info: Exploding uri music-library/USB/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去 in service mpd
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ALBUMART /albumart?cacheid=182&web=//extralarge&path=%2Fmnt%2FUSB%2FTU200Pro%2F%E7%BA%AF%E9%9F%B3%E5%8F%A4%E5%85%B8%2F%E7%BA%AF%E9%9F%B3new%20age%2F%E4%BD%95%E8%AE%AD%E7%94%B0%20-%20%E5%A6%82%E6%9D%A5%E5%A6%82%E5%8E%BB%2F%E4%BD%95%E8%AE%AD%E7%94%B0%20-%20%E5%A6%82%E6%9D%A5%E5%A6%82%E5%8E%BB.wav&metadata=false
Mar 16 23:18:09 volumio volumio[952]: info: URI /mnt/USB/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand stop took 21 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushQueue
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::saveQueue
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::updateTrackBlock
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrackBlock
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPlay
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::play index 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::stop
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::play index undefined
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::startPlaybackTimer
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::clearAddPlayTracks USB/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand stop
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 12 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand stop took 4 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 2 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 2 milliseconds
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand clear
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:18:09 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand clear took 4 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand add "USB/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav"
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: 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":"04 - IV. Più vivace Variation","artist":"Sol Gabetta","album":"Mendelssohn","uri":"USB/TU200Pro/索尼精选1-24/门德尔松大提琴作品集/CD 01/04 - IV. Più vivace Variation.flac","trackType":"flac"}
Mar 16 23:18:09 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState stateService stop
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus stop
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: No code
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 16 23:18:09 volumio volumio[952]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 50ms
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 38ms
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:18:09 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:18:09 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:18:09 volumio volumio[952]: error: updateQueue error: null
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:18:09 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 37ms
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand add "USB/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav" took 36 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 5ms
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 4ms
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand play
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:18:09 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces system playlist update
Mar 16 23:18:09 volumio volumio[952]: info: Ignoring MPD Status Update
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 14ms
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand play took 12 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 11ms
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 10ms
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 8 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 8 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 6 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 5 milliseconds
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info:
Mar 16 23:18:09 volumio volumio[952]: ---------------------------- MPD announces state update: player
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::getState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand status
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 13 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 13 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 14 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand status took 13 milliseconds
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseState
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2754,"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/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav","trackType":"wav"}
Mar 16 23:18:09 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus stop
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2754,"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/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav","trackType":"wav"}
Mar 16 23:18:09 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:18:09 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":274,"duration":2754,"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/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav","trackType":"wav"}
Mar 16 23:18:09 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:18:09 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":2754,"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/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav","trackType":"wav"}
Mar 16 23:18:09 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:18:09 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 50ms
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 97ms
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 96ms
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 94ms
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 81 milliseconds
Mar 16 23:18:09 volumio volumio[952]: info: sendMpdCommand playlistinfo took 81 milliseconds
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: verbose: ControllerMpd::parseTrackInfo
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":2754,"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/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav","trackType":"wav"}
Mar 16 23:18:09 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:18:09 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: ControllerMpd::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::servicePushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":2754,"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/TU200Pro/纯音古典/纯音new age/何训田 - 如来如去/何训田 - 如来如去.wav","trackType":"wav"}
Mar 16 23:18:09 volumio volumio[952]: verbose: CURRENT POSITION 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState stateService play
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::syncState currentStatus play
Mar 16 23:18:09 volumio volumio[952]: info: Received an update from plugin. extracting info from payload
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: CoreStateMachine::pushState
Mar 16 23:18:09 volumio volumio[952]: info: CorePlayQueue::getTrack 0
Mar 16 23:18:09 volumio volumio[952]: info: CoreCommandRouter::volumioPushState
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 134ms
Mar 16 23:18:09 volumio volumio[952]: info: ------------------------------ 134ms
Mar 16 23:18:09 volumio volumio[952]: info: MyVolumio login type: Token
Mar 16 23:18:12 volumio volumio[952]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 16 23:18:12 volumio volumio[952]: Error: connect ETIMEDOUT 67.228.235.93:443
Mar 16 23:18:12 volumio volumio[952]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Mar 16 23:18:12 volumio volumio[952]: errno: -110,
Mar 16 23:18:12 volumio volumio[952]: code: 'ETIMEDOUT',
Mar 16 23:18:12 volumio volumio[952]: syscall: 'connect',
Mar 16 23:18:12 volumio volumio[952]: address: '67.228.235.93',
Mar 16 23:18:12 volumio volumio[952]: port: 443
Mar 16 23:18:12 volumio volumio[952]: }
Mar 16 23:18:12 volumio volumio[952]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 16 23:18:13 volumio sudo[10868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 23:17
Mar 16 23:18:13 volumio sudo[10868]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET"
VOLUMIO_VERSION="3.795"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"