-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2025-06-15 04:12:02 CST. --
Jun 15 04:11:04 volumio volumio[5445]: info: Clearing queue after UPNP request
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::ClearQueue
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::stop
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 15 04:11:05 volumio volumio[5445]: info: CorePlayQueue::clearPlayQueue
Jun 15 04:11:05 volumio volumio[5445]: info: CorePlayQueue::saveQueue
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushQueue
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: error: updateQueue error: null
Jun 15 04:11:05 volumio volumio[5445]: error: updateQueue error: null
Jun 15 04:11:05 volumio volumio[5445]: error: updateQueue error: null
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 0ms
Jun 15 04:11:05 volumio volumio[5445]: info: Starting UPNP Playback
Jun 15 04:11:05 volumio volumio[5445]: info: Preparing playback through UPNP
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioGetState
Jun 15 04:11:05 volumio volumio[5445]: info: CorePlayQueue::getTrack 0
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 0ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 0ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces system playlist update
Jun 15 04:11:05 volumio volumio[5445]: info: Ignoring MPD Status Update
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 1ms
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 0ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces state update: player
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::getState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand status
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces state update: player
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::getState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand status
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces state update: player
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::getState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand status
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces state update: player
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand status took 250 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::getState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand status
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand status took 251 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand status took 250 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand status took 1 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseTrackInfo
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::servicePushState
Jun 15 04:11:05 volumio volumio[5445]: verbose: In UPNP mode
Jun 15 04:11:05 volumio volumio[5445]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":284,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"嗜好","artist":"颜人中","album":"嗜好","uri":"http://m701.music.126.net/20250615043604/50b88a083ad10aa71fbebe6b6a95df9f/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096495903/2678/762c/f570/9079e87d1bcd7d7538470f9975a0fb1e.mp3?vuutv=Glpk6EPjGygAhvYOWoiaUdYVHxiLA95OkwVui2OwpmYbwdcMFtjKimDa5ySkxqzF2VKIM3PHQIgVwGwZoJi283UPZvqG5F76B/hVmb3GcQQ=","trackType":""}
Jun 15 04:11:05 volumio volumio[5445]: verbose: CURRENT POSITION 0
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState stateService play
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState currentStatus stop
Jun 15 04:11:05 volumio volumio[5445]: info: ------------------------------ 253ms
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces state update: player
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::getState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand status
Jun 15 04:11:05 volumio volumio[5445]: info:
Jun 15 04:11:05 volumio volumio[5445]: ---------------------------- MPD announces state update: player
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::getState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand status
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand status took 1 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: info: sendMpdCommand status took 0 milliseconds
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseTrackInfo
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseTrackInfo
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseTrackInfo
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::parseState
Jun 15 04:11:05 volumio volumio[5445]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::servicePushState
Jun 15 04:11:05 volumio volumio[5445]: verbose: In UPNP mode
Jun 15 04:11:05 volumio volumio[5445]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":284,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"嗜好","artist":"颜人中","album":"嗜好","uri":"http://m701.music.126.net/20250615043604/50b88a083ad10aa71fbebe6b6a95df9f/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096495903/2678/762c/f570/9079e87d1bcd7d7538470f9975a0fb1e.mp3?vuutv=Glpk6EPjGygAhvYOWoiaUdYVHxiLA95OkwVui2OwpmYbwdcMFtjKimDa5ySkxqzF2VKIM3PHQIgVwGwZoJi283UPZvqG5F76B/hVmb3GcQQ=","trackType":""}
Jun 15 04:11:05 volumio volumio[5445]: verbose: CURRENT POSITION 0
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState stateService play
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState currentStatus play
Jun 15 04:11:05 volumio volumio[5445]: info: Received an update from plugin. extracting info from payload
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::servicePushState
Jun 15 04:11:05 volumio volumio[5445]: verbose: In UPNP mode
Jun 15 04:11:05 volumio volumio[5445]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":284,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"嗜好","artist":"颜人中","album":"嗜好","uri":"http://m701.music.126.net/20250615043604/50b88a083ad10aa71fbebe6b6a95df9f/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096495903/2678/762c/f570/9079e87d1bcd7d7538470f9975a0fb1e.mp3?vuutv=Glpk6EPjGygAhvYOWoiaUdYVHxiLA95OkwVui2OwpmYbwdcMFtjKimDa5ySkxqzF2VKIM3PHQIgVwGwZoJi283UPZvqG5F76B/hVmb3GcQQ=","trackType":""}
Jun 15 04:11:05 volumio volumio[5445]: verbose: CURRENT POSITION 0
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState stateService play
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState currentStatus play
Jun 15 04:11:05 volumio volumio[5445]: info: Received an update from plugin. extracting info from payload
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:05 volumio volumio[5445]: info: ControllerMpd::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::servicePushState
Jun 15 04:11:05 volumio volumio[5445]: verbose: In UPNP mode
Jun 15 04:11:05 volumio volumio[5445]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":284,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"嗜好","artist":"颜人中","album":"嗜好","uri":"http://m701.music.126.net/20250615043604/50b88a083ad10aa71fbebe6b6a95df9f/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096495903/2678/762c/f570/9079e87d1bcd7d7538470f9975a0fb1e.mp3?vuutv=Glpk6EPjGygAhvYOWoiaUdYVHxiLA95OkwVui2OwpmYbwdcMFtjKimDa5ySkxqzF2VKIM3PHQIgVwGwZoJi283UPZvqG5F76B/hVmb3GcQQ=","trackType":""}
Jun 15 04:11:05 volumio volumio[5445]: verbose: CURRENT POSITION 0
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState stateService play
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::syncState currentStatus play
Jun 15 04:11:05 volumio volumio[5445]: info: Received an update from plugin. extracting info from payload
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:05 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:06 volumio volumio[5445]: info: ------------------------------ 268ms
Jun 15 04:11:06 volumio volumio[5445]: info: ------------------------------ 268ms
Jun 15 04:11:06 volumio volumio[5445]: info: ------------------------------ 20ms
Jun 15 04:11:06 volumio volumio[5445]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jun 15 04:11:06 volumio volumio[5445]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jun 15 04:11:06 volumio volumio[5445]: verbose: ControllerMpd::parseTrackInfo
Jun 15 04:11:06 volumio volumio[5445]: info: ControllerMpd::pushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::servicePushState
Jun 15 04:11:06 volumio volumio[5445]: verbose: In UPNP mode
Jun 15 04:11:06 volumio volumio[5445]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":284,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"嗜好","artist":"颜人中","album":"嗜好","uri":"http://m701.music.126.net/20250615043604/50b88a083ad10aa71fbebe6b6a95df9f/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096495903/2678/762c/f570/9079e87d1bcd7d7538470f9975a0fb1e.mp3?vuutv=Glpk6EPjGygAhvYOWoiaUdYVHxiLA95OkwVui2OwpmYbwdcMFtjKimDa5ySkxqzF2VKIM3PHQIgVwGwZoJi283UPZvqG5F76B/hVmb3GcQQ=","trackType":""}
Jun 15 04:11:06 volumio volumio[5445]: verbose: CURRENT POSITION 0
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::syncState stateService play
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::syncState currentStatus play
Jun 15 04:11:06 volumio volumio[5445]: info: Received an update from plugin. extracting info from payload
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:06 volumio volumio[5445]: info: ControllerMpd::pushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::servicePushState
Jun 15 04:11:06 volumio volumio[5445]: verbose: In UPNP mode
Jun 15 04:11:06 volumio volumio[5445]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":284,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"嗜好","artist":"颜人中","album":"嗜好","uri":"http://m701.music.126.net/20250615043604/50b88a083ad10aa71fbebe6b6a95df9f/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096495903/2678/762c/f570/9079e87d1bcd7d7538470f9975a0fb1e.mp3?vuutv=Glpk6EPjGygAhvYOWoiaUdYVHxiLA95OkwVui2OwpmYbwdcMFtjKimDa5ySkxqzF2VKIM3PHQIgVwGwZoJi283UPZvqG5F76B/hVmb3GcQQ=","trackType":""}
Jun 15 04:11:06 volumio volumio[5445]: verbose: CURRENT POSITION 0
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::syncState stateService play
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::syncState currentStatus play
Jun 15 04:11:06 volumio volumio[5445]: info: Received an update from plugin. extracting info from payload
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:06 volumio volumio[5445]: info: ------------------------------ 26ms
Jun 15 04:11:06 volumio volumio[5445]: info: ------------------------------ 25ms
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:06 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:09 volumio volumio[6010]: 8
Jun 15 04:11:09 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:09 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:09 volumio volumio[5445]: info:
Jun 15 04:11:09 volumio volumio[5445]: ---------------------------- Client requests Volume 8
Jun 15 04:11:09 volumio volumio[5445]: info: VolumeController::SetAlsaVolume8
Jun 15 04:11:09 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:09 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:09 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:09 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:09 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:09 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:09 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:09 volumio volumio[6010]: {"time":1749931869798,"response":"volume Success"}8
Jun 15 04:11:10 volumio volumio[6010]: 13
Jun 15 04:11:10 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:10 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:10 volumio volumio[5445]: info:
Jun 15 04:11:10 volumio volumio[5445]: ---------------------------- Client requests Volume 13
Jun 15 04:11:10 volumio volumio[5445]: info: VolumeController::SetAlsaVolume13
Jun 15 04:11:10 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:10 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:10 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:10 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:10 volumio volumio[6010]: {"time":1749931870813,"response":"volume Success"}13
Jun 15 04:11:10 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:10 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:10 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:11 volumio volumio[6010]: 18
Jun 15 04:11:11 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:11 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:11 volumio volumio[5445]: info:
Jun 15 04:11:11 volumio volumio[5445]: ---------------------------- Client requests Volume 18
Jun 15 04:11:11 volumio volumio[5445]: info: VolumeController::SetAlsaVolume18
Jun 15 04:11:11 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:11 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:11 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:11 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:11 volumio volumio[6010]: {"time":1749931871300,"response":"volume Success"}18
Jun 15 04:11:11 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:11 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:11 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:12 volumio volumio[6010]: 23
Jun 15 04:11:12 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:12 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:12 volumio volumio[5445]: info:
Jun 15 04:11:12 volumio volumio[5445]: ---------------------------- Client requests Volume 23
Jun 15 04:11:12 volumio volumio[5445]: info: VolumeController::SetAlsaVolume23
Jun 15 04:11:12 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:12 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:12 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:12 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:12 volumio volumio[6010]: {"time":1749931872582,"response":"volume Success"}23
Jun 15 04:11:12 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:12 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:12 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:13 volumio volumio[6010]: 28
Jun 15 04:11:13 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:13 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:13 volumio volumio[5445]: info:
Jun 15 04:11:13 volumio volumio[5445]: ---------------------------- Client requests Volume 28
Jun 15 04:11:13 volumio volumio[5445]: info: VolumeController::SetAlsaVolume28
Jun 15 04:11:13 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:13 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:13 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:13 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:13 volumio volumio[6010]: {"time":1749931873415,"response":"volume Success"}28
Jun 15 04:11:13 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:13 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:13 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:14 volumio volumio[6010]: 33
Jun 15 04:11:14 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:14 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:14 volumio volumio[5445]: info:
Jun 15 04:11:14 volumio volumio[5445]: ---------------------------- Client requests Volume 33
Jun 15 04:11:14 volumio volumio[5445]: info: VolumeController::SetAlsaVolume33
Jun 15 04:11:14 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:14 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:14 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:14 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:14 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:14 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:14 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:14 volumio volumio[6010]: {"time":1749931874081,"response":"volume Success"}33
Jun 15 04:11:15 volumio volumio[6010]: 28
Jun 15 04:11:15 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:15 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:15 volumio volumio[5445]: info:
Jun 15 04:11:15 volumio volumio[5445]: ---------------------------- Client requests Volume 28
Jun 15 04:11:15 volumio volumio[5445]: info: VolumeController::SetAlsaVolume28
Jun 15 04:11:15 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:15 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:15 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:15 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:15 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:15 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:15 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:15 volumio volumio[6010]: {"time":1749931875983,"response":"volume Success"}28
Jun 15 04:11:16 volumio volumio[6010]: 23
Jun 15 04:11:16 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:16 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:16 volumio volumio[5445]: info:
Jun 15 04:11:16 volumio volumio[5445]: ---------------------------- Client requests Volume 23
Jun 15 04:11:16 volumio volumio[5445]: info: VolumeController::SetAlsaVolume23
Jun 15 04:11:16 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:16 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:16 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:16 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:16 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:16 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:16 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:16 volumio volumio[6010]: {"time":1749931876865,"response":"volume Success"}23
Jun 15 04:11:17 volumio volumio[6010]: 18
Jun 15 04:11:17 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:17 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:17 volumio volumio[5445]: info:
Jun 15 04:11:17 volumio volumio[5445]: ---------------------------- Client requests Volume 18
Jun 15 04:11:17 volumio volumio[5445]: info: VolumeController::SetAlsaVolume18
Jun 15 04:11:17 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:17 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:17 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:17 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:17 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:17 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:17 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:17 volumio volumio[6010]: {"time":1749931877825,"response":"volume Success"}18
Jun 15 04:11:18 volumio volumio[6010]: 13
Jun 15 04:11:18 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:18 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:18 volumio volumio[5445]: info:
Jun 15 04:11:18 volumio volumio[5445]: ---------------------------- Client requests Volume 13
Jun 15 04:11:18 volumio volumio[5445]: info: VolumeController::SetAlsaVolume13
Jun 15 04:11:18 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:18 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:18 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:18 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:18 volumio volumio[6010]: {"time":1749931878834,"response":"volume Success"}13
Jun 15 04:11:18 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:18 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:18 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:19 volumio volumio[6010]: 8
Jun 15 04:11:19 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:19 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:19 volumio volumio[5445]: info:
Jun 15 04:11:19 volumio volumio[5445]: ---------------------------- Client requests Volume 8
Jun 15 04:11:19 volumio volumio[5445]: info: VolumeController::SetAlsaVolume8
Jun 15 04:11:19 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:19 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:19 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:19 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:19 volumio volumio[6010]: {"time":1749931879941,"response":"volume Success"}8
Jun 15 04:11:19 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:19 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:19 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:21 volumio volumio[6010]: 3
Jun 15 04:11:21 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:21 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:21 volumio volumio[5445]: info:
Jun 15 04:11:21 volumio volumio[5445]: ---------------------------- Client requests Volume 3
Jun 15 04:11:21 volumio volumio[5445]: info: VolumeController::SetAlsaVolume3
Jun 15 04:11:21 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:21 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:21 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:21 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:21 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:21 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:21 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:21 volumio volumio[6010]: {"time":1749931881768,"response":"volume Success"}3
Jun 15 04:11:26 volumio volumio[6010]: 8
Jun 15 04:11:26 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:26 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:26 volumio volumio[5445]: info:
Jun 15 04:11:26 volumio volumio[5445]: ---------------------------- Client requests Volume 8
Jun 15 04:11:26 volumio volumio[5445]: info: VolumeController::SetAlsaVolume8
Jun 15 04:11:26 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:26 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:26 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:26 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:26 volumio volumio[6010]: {"time":1749931886638,"response":"volume Success"}8
Jun 15 04:11:26 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:26 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:26 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:27 volumio volumio[6010]: 13
Jun 15 04:11:27 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:27 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:27 volumio volumio[5445]: info:
Jun 15 04:11:27 volumio volumio[5445]: ---------------------------- Client requests Volume 13
Jun 15 04:11:27 volumio volumio[5445]: info: VolumeController::SetAlsaVolume13
Jun 15 04:11:27 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:27 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:27 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:27 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:27 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:27 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:27 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:27 volumio volumio[6010]: {"time":1749931887937,"response":"volume Success"}13
Jun 15 04:11:30 volumio volumio[6010]: 18
Jun 15 04:11:30 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:30 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:30 volumio volumio[5445]: info:
Jun 15 04:11:30 volumio volumio[5445]: ---------------------------- Client requests Volume 18
Jun 15 04:11:30 volumio volumio[5445]: info: VolumeController::SetAlsaVolume18
Jun 15 04:11:30 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:30 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:30 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:30 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:30 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:30 volumio volumio[6010]: {"time":1749931890193,"response":"volume Success"}18
Jun 15 04:11:30 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:30 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:33 volumio volumio[6010]: 13
Jun 15 04:11:33 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:33 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:33 volumio volumio[5445]: info:
Jun 15 04:11:33 volumio volumio[5445]: ---------------------------- Client requests Volume 13
Jun 15 04:11:33 volumio volumio[5445]: info: VolumeController::SetAlsaVolume13
Jun 15 04:11:33 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:33 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:33 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:33 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:33 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:33 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:33 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:33 volumio volumio[6010]: {"time":1749931893224,"response":"volume Success"}13
Jun 15 04:11:35 volumio volumio[6010]: 8
Jun 15 04:11:35 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:35 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:35 volumio volumio[5445]: info:
Jun 15 04:11:35 volumio volumio[5445]: ---------------------------- Client requests Volume 8
Jun 15 04:11:35 volumio volumio[5445]: info: VolumeController::SetAlsaVolume8
Jun 15 04:11:35 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:35 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:35 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:35 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:35 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:35 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:35 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:35 volumio volumio[6010]: {"time":1749931895218,"response":"volume Success"}8
Jun 15 04:11:38 volumio nmbd[928]: [2025/06/15 04:11:38.864656, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Jun 15 04:11:38 volumio nmbd[928]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable
Jun 15 04:11:52 volumio volumio[6010]: 3
Jun 15 04:11:52 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:52 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:52 volumio volumio[5445]: info:
Jun 15 04:11:52 volumio volumio[5445]: ---------------------------- Client requests Volume 3
Jun 15 04:11:52 volumio volumio[5445]: info: VolumeController::SetAlsaVolume3
Jun 15 04:11:52 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:52 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:52 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:52 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:52 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:52 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:52 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:52 volumio volumio[6010]: {"time":1749931912164,"response":"volume Success"}3
Jun 15 04:11:54 volumio volumio[6010]: 8
Jun 15 04:11:54 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:54 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:54 volumio volumio[5445]: info:
Jun 15 04:11:54 volumio volumio[5445]: ---------------------------- Client requests Volume 8
Jun 15 04:11:54 volumio volumio[5445]: info: VolumeController::SetAlsaVolume8
Jun 15 04:11:54 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:54 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:54 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:54 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:54 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:54 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:54 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:54 volumio volumio[6010]: {"time":1749931914867,"response":"volume Success"}8
Jun 15 04:11:56 volumio volumio[6010]: 3
Jun 15 04:11:56 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:56 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:56 volumio volumio[5445]: info:
Jun 15 04:11:56 volumio volumio[5445]: ---------------------------- Client requests Volume 3
Jun 15 04:11:56 volumio volumio[5445]: info: VolumeController::SetAlsaVolume3
Jun 15 04:11:56 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:56 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:56 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:56 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:56 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:56 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:56 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:56 volumio volumio[6010]: {"time":1749931916034,"response":"volume Success"}3
Jun 15 04:11:56 volumio volumio[6010]: 0
Jun 15 04:11:56 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:56 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:56 volumio volumio[5445]: info:
Jun 15 04:11:56 volumio volumio[5445]: ---------------------------- Client requests Volume 1
Jun 15 04:11:56 volumio volumio[5445]: info: VolumeController::SetAlsaVolume1
Jun 15 04:11:56 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:56 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:56 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:56 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:56 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:56 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:56 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:11:56 volumio volumio[6010]: {"time":1749931916765,"response":"volume Success"}1
Jun 15 04:11:57 volumio volumio[6010]: 6
Jun 15 04:11:57 volumio volumio[6010]: % Total % Received % Xferd Average Speed Time Time Time Current
Jun 15 04:11:57 volumio volumio[6010]: Dload Upload Total Spent Left Speed
Jun 15 04:11:57 volumio volumio[5445]: info:
Jun 15 04:11:57 volumio volumio[5445]: ---------------------------- Client requests Volume 6
Jun 15 04:11:57 volumio volumio[5445]: info: VolumeController::SetAlsaVolume6
Jun 15 04:11:57 volumio volumio[5445]: info: CoreStateMachine::pushState
Jun 15 04:11:57 volumio volumio[5445]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 15 04:11:57 volumio volumio[5445]: info: CoreCommandRouter::volumioPushState
Jun 15 04:11:57 volumio volumio[6010]: [158B blob data]
Jun 15 04:11:57 volumio volumio[5445]: info: CoreCommandRouter::volumioGetQueue
Jun 15 04:11:57 volumio volumio[6010]: {"time":1749931917922,"response":"volume Success"}6
Jun 15 04:11:57 volumio volumio[5445]: info: CoreStateMachine::getQueue
Jun 15 04:11:57 volumio volumio[5445]: info: CorePlayQueue::getQueue
Jun 15 04:12:02 volumio volumio[5445]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 15 04:12:02 volumio volumio[5445]: Error: connect ETIMEDOUT 31.13.76.65:80
Jun 15 04:12:02 volumio volumio[5445]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Jun 15 04:12:02 volumio volumio[5445]: errno: -110,
Jun 15 04:12:02 volumio volumio[5445]: code: 'ETIMEDOUT',
Jun 15 04:12:02 volumio volumio[5445]: syscall: 'connect',
Jun 15 04:12:02 volumio volumio[5445]: address: '31.13.76.65',
Jun 15 04:12:02 volumio volumio[5445]: port: 80
Jun 15 04:12:02 volumio volumio[5445]: }
Jun 15 04:12:02 volumio volumio[5445]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 15 04:12:02 volumio sudo[7533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-15 04:11
Jun 15 04:12:02 volumio sudo[7533]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST"
VOLUMIO_VERSION="3.816"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"