-- Logs begin at Tue 2024-10-01 13:30:28 UTC, end at Tue 2024-10-01 14:07:57 UTC. -- Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPlay Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::play index 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::play index undefined Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::startPlaybackTimer Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::clearAddPlayTracks USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/我们不是只有现在吗.wav Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand stop took 2 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clear Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:02 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand clear took 1 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand add "USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/我们不是只有现在吗.wav" Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:02 volumio volumio[765]: error: updateQueue error: null Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:02 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand status took 5 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 5ms Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand add "USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/我们不是只有现在吗.wav" took 5 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand status took 4 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand status took 3 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand play Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: 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} Oct 01 14:06:02 volumio volumio[765]: verbose: CURRENT POSITION 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState stateService stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: No code Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: 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} Oct 01 14:06:02 volumio volumio[765]: verbose: CURRENT POSITION 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState stateService stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: No code Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: 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} Oct 01 14:06:02 volumio volumio[765]: verbose: CURRENT POSITION 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState stateService stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: No code Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 39ms Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 38ms Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 38ms Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:02 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:02 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 41ms Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand play took 41 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 5ms Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 3ms Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:02 volumio volumio[765]: info: Oct 01 14:06:02 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand status took 27 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand status took 28 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand status took 33 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand status took 34 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand clearerror took 24 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand clearerror took 28 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand clearerror took 27 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand playlistinfo took 17 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 01 14:06:02 volumio volumio[765]: info: sendMpdCommand playlistinfo took 14 milliseconds Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseTrackInfo Oct 01 14:06:02 volumio volumio[765]: verbose: ControllerMpd::parseTrackInfo Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/我们不是只有现在吗.wav","trackType":"wav"} Oct 01 14:06:02 volumio volumio[765]: verbose: CURRENT POSITION 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/我们不是只有现在吗.wav","trackType":"wav"} Oct 01 14:06:02 volumio volumio[765]: verbose: CURRENT POSITION 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/我们不是只有现在吗.wav","trackType":"wav"} Oct 01 14:06:02 volumio volumio[765]: verbose: CURRENT POSITION 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/我们不是只有现在吗.wav","trackType":"wav"} Oct 01 14:06:02 volumio volumio[765]: verbose: CURRENT POSITION 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:02 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:02 volumio volumio[765]: info: CorePlayQueue::getTrack 153 Oct 01 14:06:02 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 117ms Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 119ms Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 118ms Oct 01 14:06:02 volumio volumio[765]: info: ------------------------------ 117ms Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPlay Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::play index 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::play index undefined Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::startPlaybackTimer Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::clearAddPlayTracks USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand stop took 3 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clear Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:03 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 5 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand clear took 4 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 3 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 2 milliseconds Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand add "USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav" Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: 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} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: No code Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: 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} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: No code Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 25ms Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:03 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:03 volumio volumio[765]: error: updateQueue error: null Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:03 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 27ms Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand playlistinfo took 26 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand add "USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav" took 26 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 3ms Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseTrackInfo Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand play Oct 01 14:06:03 volumio volumio[765]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 34ms Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:03 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:03 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 18ms Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand play took 16 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 15ms Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 14ms Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces system playlist update Oct 01 14:06:03 volumio volumio[765]: info: Ignoring MPD Status Update Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 10 milliseconds Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 11 milliseconds Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 11 milliseconds Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 18ms Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 15 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand clearerror took 13 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand clearerror took 11 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand clearerror took 10 milliseconds Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:03 volumio volumio[765]: info: Oct 01 14:06:03 volumio volumio[765]: ---------------------------- MPD announces state update: player Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::getState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand status Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 9 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand clearerror took 6 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand status took 2 milliseconds Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseTrackInfo Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseTrackInfo Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseState Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav","trackType":"wav"} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav","trackType":"wav"} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav","trackType":"wav"} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav","trackType":"wav"} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 77ms Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 76ms Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 76ms Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 77ms Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand playlistinfo took 54 milliseconds Oct 01 14:06:03 volumio volumio[765]: info: sendMpdCommand playlistinfo took 55 milliseconds Oct 01 14:06:03 volumio volumio[765]: verbose: ControllerMpd::parseTrackInfo Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav","trackType":"wav"} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ControllerMpd::pushState Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::servicePushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"??","album":"?????2","uri":"USB/ESD-USB/16.1（煲机音乐仅试听）/歌曲试听 02/枫收藏《乐坛风向标》CD2/回家以后.wav","trackType":"wav"} Oct 01 14:06:03 volumio volumio[765]: verbose: CURRENT POSITION 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState stateService pause Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::syncState currentStatus stop Oct 01 14:06:03 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:03 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:03 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 85ms Oct 01 14:06:03 volumio volumio[765]: info: ------------------------------ 78ms Oct 01 14:06:06 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:06:06 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:06:06 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:06:06 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:06:06 volumio volumio[765]: info: CorePlayQueue::getTrack 149 Oct 01 14:06:06 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:06:11 volumio volumio[765]: info: CoreCommandRouter::volumioRemoveQueueItem Oct 01 14:06:11 volumio volumio[765]: info: CoreStateMachine::removeQueueItem Oct 01 14:06:11 volumio volumio[765]: info: CorePlayQueue::removeQueueItem 0 Oct 01 14:06:11 volumio volumio[765]: info: CorePlayQueue::saveQueue Oct 01 14:06:11 volumio volumio[765]: info: CoreCommandRouter::volumioPushQueue Oct 01 14:06:21 volumio volumio[765]: info: CoreCommandRouter::volumioClearQueue Oct 01 14:06:21 volumio volumio[765]: info: CoreStateMachine::ClearQueue Oct 01 14:06:21 volumio volumio[765]: info: CoreStateMachine::stop Oct 01 14:06:21 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:21 volumio volumio[765]: info: CorePlayQueue::clearPlayQueue Oct 01 14:06:21 volumio volumio[765]: info: CorePlayQueue::saveQueue Oct 01 14:06:21 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:21 volumio volumio[765]: info: CoreCommandRouter::volumioPushQueue Oct 01 14:06:29 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: mpd , lsInfo Oct 01 14:06:29 volumio volumio[765]: info: Saving local item undefined Oct 01 14:06:29 volumio volumio[765]: info: Pushing Favourites {"uri":"","favourite":false} Oct 01 14:06:29 volumio volumio[765]: info: Listing playlists Oct 01 14:06:36 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:06:36 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:06:36 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:06:36 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:06:36 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:36 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:06:37 volumio volumio[765]: info: CoreCommandRouter::volumioRandom Oct 01 14:06:37 volumio volumio[765]: info: CoreCommandRouter::writePlayerControls Oct 01 14:06:37 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:37 volumio volumio[765]: info: CoreStateMachine::setRepeat true single false Oct 01 14:06:37 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:37 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:37 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 14:06:37 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:38 volumio volumio[765]: info: CoreCommandRouter::volumioRandom Oct 01 14:06:38 volumio volumio[765]: info: CoreCommandRouter::writePlayerControls Oct 01 14:06:38 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:38 volumio volumio[765]: info: CoreStateMachine::setRepeat true single true Oct 01 14:06:38 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:38 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:38 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 14:06:38 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:48 volumio volumio[765]: info: CoreCommandRouter::volumioRandom Oct 01 14:06:48 volumio volumio[765]: info: CoreCommandRouter::writePlayerControls Oct 01 14:06:48 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:48 volumio volumio[765]: info: CoreStateMachine::setRandom true Oct 01 14:06:48 volumio volumio[765]: info: CoreStateMachine::pushState Oct 01 14:06:48 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:48 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 14:06:48 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:49 volumio volumio[765]: info: CoreCommandRouter::volumioClearQueue Oct 01 14:06:49 volumio volumio[765]: info: CoreStateMachine::ClearQueue Oct 01 14:06:49 volumio volumio[765]: info: CoreStateMachine::stop Oct 01 14:06:49 volumio volumio[765]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 14:06:49 volumio volumio[765]: info: CorePlayQueue::clearPlayQueue Oct 01 14:06:49 volumio volumio[765]: info: CorePlayQueue::saveQueue Oct 01 14:06:49 volumio volumio[765]: info: CoreCommandRouter::volumioPushState Oct 01 14:06:49 volumio volumio[765]: info: CoreCommandRouter::volumioPushQueue Oct 01 14:06:56 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:06:56 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:06:56 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:06:56 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:06:56 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:56 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:06:56 volumio volumio[765]: verbose: New Socket.io Connection to 192.168.50.171:3000 from 192.168.50.96 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 01 14:06:56 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:06:56 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:06:56 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 01 14:06:56 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:07:01 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:07:01 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:07:01 volumio sudo[3472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 01 14:07:01 volumio sudo[3472]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:01 volumio sudo[3472]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:01 volumio sudo[3474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 01 14:07:01 volumio sudo[3474]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:01 volumio sudo[3474]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:01 volumio volumio[765]: verbose: New Socket.io Connection to 192.168.50.171 from 192.168.50.96 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 01 14:07:01 volumio sudo[3480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 01 14:07:01 volumio sudo[3480]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:01 volumio sudo[3480]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:01 volumio sudo[3483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 01 14:07:01 volumio sudo[3483]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:01 volumio sudo[3483]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:01 volumio volumio[765]: verbose: New Socket.io Connection to 192.168.50.171 from 192.168.50.96 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::volumioGetVisibleSources Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:07:01 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 01 14:07:01 volumio volumio[765]: info: Received Get System Info Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:07:01 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:07:01 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:07:01 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:07:01 volumio volumio[765]: info: Listing playlists Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 01 14:07:01 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 01 14:07:02 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 01 14:07:02 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 01 14:07:03 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 01 14:07:03 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 01 14:07:03 volumio volumio[765]: info: Received Get System Info Oct 01 14:07:03 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:07:03 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:07:03 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:07:03 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:07:03 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:07:03 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:07:05 volumio volumio[765]: info: CoreCommandRouter::volumioGetQueue Oct 01 14:07:05 volumio volumio[765]: info: CoreStateMachine::getQueue Oct 01 14:07:05 volumio volumio[765]: info: CorePlayQueue::getQueue Oct 01 14:07:11 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 01 14:07:17 volumio volumio[765]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 14:07:17 volumio volumio[765]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Oct 01 14:07:17 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 01 14:07:17 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 01 14:07:17 volumio sudo[3490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 01 14:07:17 volumio sudo[3490]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:17 volumio sudo[3490]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:17 volumio sudo[3495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 01 14:07:17 volumio sudo[3495]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:17 volumio sudo[3502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 01 14:07:17 volumio sudo[3502]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:18 volumio sudo[3495]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:18 volumio sudo[3510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 01 14:07:18 volumio sudo[3502]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:18 volumio sudo[3510]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:18 volumio sudo[3522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 01 14:07:18 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 01 14:07:18 volumio sudo[3522]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:18 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 01 14:07:18 volumio sudo[3510]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:18 volumio sudo[3522]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:18 volumio sudo[3527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 01 14:07:18 volumio sudo[3527]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:18 volumio sudo[3527]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:18 volumio sudo[3535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 01 14:07:18 volumio sudo[3535]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:18 volumio sudo[3535]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:18 volumio volumio[765]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 01 14:07:18 volumio volumio[765]: wlan0 Interface doesn't support scanning. Oct 01 14:07:18 volumio volumio[765]: info: Cannot use regular scanning, forcing with ap-force Oct 01 14:07:18 volumio sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 01 14:07:18 volumio sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:18 volumio sudo[3541]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:18 volumio volumio[765]: command failed: No such device (-19) Oct 01 14:07:18 volumio volumio[765]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 01 14:07:18 volumio volumio[765]: command failed: No such device (-19) Oct 01 14:07:24 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:07:24 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:07:24 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:07:24 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:07:24 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:07:24 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:07:51 volumio kernel: usb 3-1: new high-speed USB device number 2 using ehci-pci Oct 01 14:07:52 volumio kernel: usb 3-1: New USB device found, idVendor=0846, idProduct=9052, bcdDevice= 2.00 Oct 01 14:07:52 volumio kernel: usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Oct 01 14:07:52 volumio kernel: usb 3-1: Product: 802.11ac WLAN Adapter Oct 01 14:07:52 volumio kernel: usb 3-1: Manufacturer: Realtek Oct 01 14:07:52 volumio kernel: usb 3-1: SerialNumber: 00e04c000001 Oct 01 14:07:54 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 14:07:54 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 14:07:54 volumio volumio[765]: info: Discovery: Getting this device information Oct 01 14:07:54 volumio volumio[765]: info: CoreCommandRouter::volumioGetState Oct 01 14:07:54 volumio volumio[765]: info: CorePlayQueue::getTrack 148 Oct 01 14:07:54 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 14:07:56 volumio volumio[765]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Oct 01 14:07:56 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Oct 01 14:07:56 volumio sudo[3593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Oct 01 14:07:56 volumio sudo[3593]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:56 volumio sudo[3593]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:56 volumio sudo[3595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Oct 01 14:07:56 volumio sudo[3595]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:56 volumio sudo[3595]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:56 volumio volumio[765]: info: Permissions for /etc/network/interfaces set Oct 01 14:07:56 volumio volumio[765]: info: Restarting Wireless Network Oct 01 14:07:56 volumio volumio[765]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Oct 01 14:07:56 volumio volumio[765]: info: Discovery: Restarting Advertising due to device name change Oct 01 14:07:56 volumio sudo[3599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Oct 01 14:07:56 volumio sudo[3599]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 14:07:56 volumio systemd[1]: Starting Wireless Services... Oct 01 14:07:56 volumio wireless.js[3601]: WIRELESS: No wireless interface, exiting Oct 01 14:07:56 volumio iw[3613]: command failed: No such device (-19) Oct 01 14:07:57 volumio iwconfig[3616]: Error for wireless request "Set Power Management" (8B2C) : Oct 01 14:07:57 volumio iwconfig[3616]: SET failed on device wlan0 ; No such device. Oct 01 14:07:57 volumio systemd[1]: wireless.service: Succeeded. Oct 01 14:07:57 volumio systemd[1]: Started Wireless Services. Oct 01 14:07:57 volumio sudo[3599]: pam_unix(sudo:session): session closed for user root Oct 01 14:07:57 volumio volumio[765]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 14:07:57 volumio volumio[765]: Error: connect ETIMEDOUT 185.60.216.11:80 Oct 01 14:07:57 volumio volumio[765]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 01 14:07:57 volumio volumio[765]: errno: -110, Oct 01 14:07:57 volumio volumio[765]: code: 'ETIMEDOUT', Oct 01 14:07:57 volumio volumio[765]: syscall: 'connect', Oct 01 14:07:57 volumio volumio[765]: address: '185.60.216.11', Oct 01 14:07:57 volumio volumio[765]: port: 80 Oct 01 14:07:57 volumio volumio[765]: } Oct 01 14:07:57 volumio volumio[765]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 14:07:57 volumio sudo[3629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 14:06 Oct 01 14:07:57 volumio sudo[3629]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"