-- Logs begin at Sat 2025-07-05 19:59:10 CST, end at Sat 2025-07-05 20:22:27 CST. -- Jul 05 20:21:21 volumio volumio[764]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 18 Jul 05 20:21:36 volumio volumio[764]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 19 Jul 05 20:21:36 volumio volumio[764]: info: CoreCommandRouter::volumioGetState Jul 05 20:21:36 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: info: Preload queue cleared Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::ClearQueue Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::stPlaybackTimer Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::serviceStop Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::serviceStop Jul 05 20:21:53 volumio volumio[764]: info: ControllerMpd::stop Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::clearPlayQueue Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::addQueueItems Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::addQueueItems Jul 05 20:21:53 volumio volumio[764]: info: Preload queue cleared Jul 05 20:21:53 volumio volumio[764]: info: Adding Item to queue: albums://%E9%BB%92%E7%9F%B3%E3%81%B2%E3%81%A8%E3%81%BF/%E3%82%B3%E3%83%BC%E3%83%89%E3%82%AE%E3%82%A2%E3%82%B9%20%E5%8F%8D%E9%80%86%E3%81%AE%E3%83%AB%E3%83%AB%E3%83%BC%E3%82%B7%E3%83%A5R2%20O.S.T. Jul 05 20:21:53 volumio volumio[764]: info: Exploding uri albums://%E9%BB%92%E7%9F%B3%E3%81%B2%E3%81%A8%E3%81%BF/%E3%82%B3%E3%83%BC%E3%83%89%E3%82%AE%E3%82%A2%E3%82%B9%20%E5%8F%8D%E9%80%86%E3%81%AE%E3%83%AB%E3%83%AB%E3%83%BC%E3%82%B7%E3%83%A5R2%20O.S.T. in service mpd Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioPlay Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::play index 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::play index undefined Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::startPlaybackTimer Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::clearAddPlayTracks USB/music/黒石ひとみ - If I were a Bird.mp3 Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand stop took 45 milliseconds Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:21:53 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand stop took 28 milliseconds Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:21:53 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:21:53 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand status took 3 milliseconds Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand clear took 3 milliseconds Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand add "USB/music/黒石ひとみ - If I were a Bird.mp3" Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:21:53 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:21:53 volumio volumio[764]: error: updateQueue error: null Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:21:53 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand status took 6 milliseconds Jul 05 20:21:53 volumio volumio[764]: info: ------------------------------ 5ms Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand add "USB/music/黒石ひとみ - If I were a Bird.mp3" took 3 milliseconds Jul 05 20:21:53 volumio volumio[764]: info: ------------------------------ 4ms Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand play Jul 05 20:21:53 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: 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} Jul 05 20:21:53 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::syncState stateService stop Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:53 volumio volumio[764]: info: No code Jul 05 20:21:53 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:53 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:53 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:53 volumio volumio[764]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 20:21:53 volumio volumio[764]: info: ------------------------------ 26ms Jul 05 20:21:53 volumio volumio[764]: info: ------------------------------ 29ms Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:21:53 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:21:53 volumio volumio[764]: info: ------------------------------ 24ms Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand play took 21 milliseconds Jul 05 20:21:53 volumio volumio[764]: info: ------------------------------ 2ms Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:21:53 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:21:53 volumio volumio[764]: info: Jul 05 20:21:53 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:21:53 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:21:53 volumio volumio[764]: info: sendMpdCommand status took 4 milliseconds Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:21:53 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:21:54 volumio volumio[764]: info: Jul 05 20:21:54 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:21:54 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:21:54 volumio volumio[764]: info: sendMpdCommand status took 9 milliseconds Jul 05 20:21:54 volumio volumio[764]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:21:54 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":108,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"If I were a Bird","artist":"黒石ひとみ","album":"コードギアス 反逆のルルーシュR2 O.S.T.","uri":"USB/music/黒石ひとみ - If I were a Bird.mp3","trackType":"mp3"} Jul 05 20:21:54 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:21:54 volumio volumio[764]: info: ------------------------------ 13ms Jul 05 20:21:54 volumio volumio[764]: info: Jul 05 20:21:54 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:21:54 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:21:54 volumio volumio[764]: info: sendMpdCommand status took 4 milliseconds Jul 05 20:21:54 volumio volumio[764]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:21:54 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":108,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"If I were a Bird","artist":"黒石ひとみ","album":"コードギアス 反逆のルルーシュR2 O.S.T.","uri":"USB/music/黒石ひとみ - If I were a Bird.mp3","trackType":"mp3"} Jul 05 20:21:54 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:21:54 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:54 volumio volumio[764]: info: ------------------------------ 27ms Jul 05 20:21:54 volumio volumio[764]: info: sendMpdCommand status took 15 milliseconds Jul 05 20:21:54 volumio volumio[764]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:21:54 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":108,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"If I were a Bird","artist":"黒石ひとみ","album":"コードギアス 反逆のルルーシュR2 O.S.T.","uri":"USB/music/黒石ひとみ - If I were a Bird.mp3","trackType":"mp3"} Jul 05 20:21:54 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:21:54 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:54 volumio volumio[764]: info: ------------------------------ 35ms Jul 05 20:21:54 volumio volumio[764]: info: sendMpdCommand playlistinfo took 25 milliseconds Jul 05 20:21:54 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:21:54 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":108,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"If I were a Bird","artist":"黒石ひとみ","album":"コードギアス 反逆のルルーシュR2 O.S.T.","uri":"USB/music/黒石ひとみ - If I were a Bird.mp3","trackType":"mp3"} Jul 05 20:21:54 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:21:54 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:54 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:21:54 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:21:54 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:21:54 volumio volumio[764]: info: ------------------------------ 53ms Jul 05 20:21:58 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 20:21:58 volumio volumio[764]: info: CURURI: albums://%E5%BA%84%E6%8C%AF%E5%87%AF%E3%80%81%E6%9E%97%E4%BF%8A%E5%90%89/%E4%B8%80%E5%A3%B0%E7%88%B1 Jul 05 20:21:58 volumio volumio[764]: info: Preload queue cleared Jul 05 20:21:58 volumio volumio[764]: info: No valid Plugin REST Endpoint Jul 05 20:22:00 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::ClearQueue Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::stPlaybackTimer Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::serviceStop Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::serviceStop Jul 05 20:22:00 volumio volumio[764]: info: ControllerMpd::stop Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::clearPlayQueue Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::addQueueItems Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::addQueueItems Jul 05 20:22:00 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:00 volumio volumio[764]: info: Adding Item to queue: albums://%E5%BA%84%E6%8C%AF%E5%87%AF%E3%80%81%E6%9E%97%E4%BF%8A%E5%90%89/%E4%B8%80%E5%A3%B0%E7%88%B1 Jul 05 20:22:00 volumio volumio[764]: info: Exploding uri albums://%E5%BA%84%E6%8C%AF%E5%87%AF%E3%80%81%E6%9E%97%E4%BF%8A%E5%90%89/%E4%B8%80%E5%A3%B0%E7%88%B1 in service mpd Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioPlay Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::play index 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::play index undefined Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::startPlaybackTimer Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::clearAddPlayTracks USB/music/庄振凯、林俊吉 - 兄弟.mp3 Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:22:00 volumio volumio[764]: info: Jul 05 20:22:00 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand stop took 44 milliseconds Jul 05 20:22:00 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand stop took 25 milliseconds Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 20:22:00 volumio volumio[764]: info: Jul 05 20:22:00 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:00 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:00 volumio volumio[764]: info: Jul 05 20:22:00 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:00 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand status took 3 milliseconds Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand clear took 3 milliseconds Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand add "USB/music/庄振凯、林俊吉 - 兄弟.mp3" Jul 05 20:22:00 volumio volumio[764]: info: Jul 05 20:22:00 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:00 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:00 volumio volumio[764]: error: updateQueue error: null Jul 05 20:22:00 volumio volumio[764]: info: Jul 05 20:22:00 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:00 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand status took 3 milliseconds Jul 05 20:22:00 volumio volumio[764]: info: ------------------------------ 3ms Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand add "USB/music/庄振凯、林俊吉 - 兄弟.mp3" took 3 milliseconds Jul 05 20:22:00 volumio volumio[764]: info: ------------------------------ 2ms Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:00 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand play Jul 05 20:22:00 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: 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} Jul 05 20:22:00 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::syncState stateService stop Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:00 volumio volumio[764]: info: No code Jul 05 20:22:00 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:00 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:00 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:00 volumio volumio[764]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 20:22:00 volumio volumio[764]: info: ------------------------------ 20ms Jul 05 20:22:00 volumio volumio[764]: info: ------------------------------ 22ms Jul 05 20:22:00 volumio volumio[764]: info: Jul 05 20:22:00 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:00 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:00 volumio volumio[764]: info: ------------------------------ 18ms Jul 05 20:22:00 volumio volumio[764]: info: sendMpdCommand play took 18 milliseconds Jul 05 20:22:00 volumio volumio[764]: info: ------------------------------ 2ms Jul 05 20:22:01 volumio volumio[764]: info: Jul 05 20:22:01 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:01 volumio volumio[764]: info: Jul 05 20:22:01 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:01 volumio volumio[764]: info: Jul 05 20:22:01 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand status took 6 milliseconds Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand status took 7 milliseconds Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand status took 3 milliseconds Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"兄弟","artist":"庄振凯、林俊吉","album":"一声爱","uri":"USB/music/庄振凯、林俊吉 - 兄弟.mp3","trackType":"mp3"} Jul 05 20:22:01 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:22:01 volumio volumio[764]: info: ------------------------------ 16ms Jul 05 20:22:01 volumio volumio[764]: info: Jul 05 20:22:01 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand status took 1 milliseconds Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"兄弟","artist":"庄振凯、林俊吉","album":"一声爱","uri":"USB/music/庄振凯、林俊吉 - 兄弟.mp3","trackType":"mp3"} Jul 05 20:22:01 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:01 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":315,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"兄弟","artist":"庄振凯、林俊吉","album":"一声爱","uri":"USB/music/庄振凯、林俊吉 - 兄弟.mp3","trackType":"mp3"} Jul 05 20:22:01 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:01 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:01 volumio volumio[764]: info: ------------------------------ 37ms Jul 05 20:22:01 volumio volumio[764]: info: ------------------------------ 33ms Jul 05 20:22:01 volumio volumio[764]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 05 20:22:01 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:01 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":315,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"兄弟","artist":"庄振凯、林俊吉","album":"一声爱","uri":"USB/music/庄振凯、林俊吉 - 兄弟.mp3","trackType":"mp3"} Jul 05 20:22:01 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:01 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:01 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:01 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:01 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:01 volumio volumio[764]: info: ------------------------------ 35ms Jul 05 20:22:08 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 20:22:08 volumio volumio[764]: info: CURURI: artists:// Jul 05 20:22:08 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:14 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 05 20:22:14 volumio volumio[764]: info: CURURI: albums:// Jul 05 20:22:14 volumio volumio[764]: info: listAlbums - loading Albums from cache Jul 05 20:22:14 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:18 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::ClearQueue Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::stPlaybackTimer Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::serviceStop Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::serviceStop Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::stop Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::clearPlayQueue Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::addQueueItems Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::addQueueItems Jul 05 20:22:18 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:18 volumio volumio[764]: info: Adding Item to queue: albums://%E7%8E%8B%E7%8E%89%E7%8F%8D/%E4%B8%AD%E5%9B%BD%E6%AD%8C%E5%89%A7%E7%BB%8F%E5%85%B8%E5%90%8D%E6%9B%B2 Jul 05 20:22:18 volumio volumio[764]: info: Exploding uri albums://%E7%8E%8B%E7%8E%89%E7%8F%8D/%E4%B8%AD%E5%9B%BD%E6%AD%8C%E5%89%A7%E7%BB%8F%E5%85%B8%E5%90%8D%E6%9B%B2 in service mpd Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPlay Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::play index 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::play index undefined Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::startPlaybackTimer Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::clearAddPlayTracks USB/music/王玉珍 - 小曲好唱口难开.mp3 Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand stop took 50 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand stop took 33 milliseconds Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:18 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand status took 2 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand clear took 2 milliseconds Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand add "USB/music/王玉珍 - 小曲好唱口难开.mp3" Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:18 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:18 volumio volumio[764]: error: updateQueue error: null Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:18 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand status took 4 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 5ms Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand add "USB/music/王玉珍 - 小曲好唱口难开.mp3" took 5 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 5ms Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand play Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: 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} Jul 05 20:22:18 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState stateService stop Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: No code Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 33ms Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 35ms Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:18 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 33ms Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand play took 28 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 2ms Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand status took 6 milliseconds Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand status took 6 milliseconds Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:18 volumio volumio[764]: info: Jul 05 20:22:18 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand status took 4 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand status took 2 milliseconds Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"小曲好唱口难开","artist":"王玉珍","album":"中国歌剧经典名曲","uri":"USB/music/王玉珍 - 小曲好唱口难开.mp3","trackType":"mp3"} Jul 05 20:22:18 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"小曲好唱口难开","artist":"王玉珍","album":"中国歌剧经典名曲","uri":"USB/music/王玉珍 - 小曲好唱口难开.mp3","trackType":"mp3"} Jul 05 20:22:18 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:18 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 23ms Jul 05 20:22:18 volumio volumio[764]: info: ------------------------------ 27ms Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 05 20:22:18 volumio volumio[764]: info: sendMpdCommand playlistinfo took 15 milliseconds Jul 05 20:22:18 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":352,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"小曲好唱口难开","artist":"王玉珍","album":"中国歌剧经典名曲","uri":"USB/music/王玉珍 - 小曲好唱口难开.mp3","trackType":"mp3"} Jul 05 20:22:18 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:18 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"小曲好唱口难开","artist":"王玉珍","album":"中国歌剧经典名曲","uri":"USB/music/王玉珍 - 小曲好唱口难开.mp3","trackType":"mp3"} Jul 05 20:22:18 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:18 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:18 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:18 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:18 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:19 volumio volumio[764]: info: ------------------------------ 48ms Jul 05 20:22:19 volumio volumio[764]: info: ------------------------------ 47ms Jul 05 20:22:23 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::ClearQueue Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::stPlaybackTimer Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::serviceStop Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::serviceStop Jul 05 20:22:23 volumio volumio[764]: info: ControllerMpd::stop Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::clearPlayQueue Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::addQueueItems Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::addQueueItems Jul 05 20:22:23 volumio volumio[764]: info: Preload queue cleared Jul 05 20:22:23 volumio volumio[764]: info: Adding Item to queue: albums://%E9%98%BF%E5%90%89%E4%BB%94/%E5%86%8D%E6%98%BE%E5%A5%87%E8%BF%B9 Jul 05 20:22:23 volumio volumio[764]: info: Exploding uri albums://%E9%98%BF%E5%90%89%E4%BB%94/%E5%86%8D%E6%98%BE%E5%A5%87%E8%BF%B9 in service mpd Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioPushQueue Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::saveQueue Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::updateTrackBlock Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrackBlock Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioPlay Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::play index 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::stop Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::play index undefined Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::startPlaybackTimer Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::clearAddPlayTracks USB/music/阿吉仔 - 看人生.mp3 Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 20:22:23 volumio volumio[764]: info: Jul 05 20:22:23 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand stop took 35 milliseconds Jul 05 20:22:23 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand stop took 19 milliseconds Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand status took 0 milliseconds Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:23 volumio volumio[764]: info: Jul 05 20:22:23 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:23 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:23 volumio volumio[764]: info: Jul 05 20:22:23 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:23 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand clear took 2 milliseconds Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand status took 2 milliseconds Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand add "USB/music/阿吉仔 - 看人生.mp3" Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:23 volumio volumio[764]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 20:22:23 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: 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} Jul 05 20:22:23 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::syncState stateService stop Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:23 volumio volumio[764]: info: No code Jul 05 20:22:23 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:23 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:23 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:23 volumio volumio[764]: info: ------------------------------ 13ms Jul 05 20:22:23 volumio volumio[764]: info: ------------------------------ 20ms Jul 05 20:22:23 volumio volumio[764]: info: Jul 05 20:22:23 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:23 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:23 volumio volumio[764]: error: updateQueue error: null Jul 05 20:22:23 volumio volumio[764]: info: Jul 05 20:22:23 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:23 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:23 volumio volumio[764]: info: ------------------------------ 22ms Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand add "USB/music/阿吉仔 - 看人生.mp3" took 21 milliseconds Jul 05 20:22:23 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand play Jul 05 20:22:23 volumio volumio[764]: info: ------------------------------ 10ms Jul 05 20:22:23 volumio volumio[764]: info: ------------------------------ 11ms Jul 05 20:22:23 volumio volumio[764]: info: sendMpdCommand play took 10 milliseconds Jul 05 20:22:23 volumio volumio[764]: info: Jul 05 20:22:23 volumio volumio[764]: ---------------------------- MPD announces system playlist update Jul 05 20:22:23 volumio volumio[764]: info: Ignoring MPD Status Update Jul 05 20:22:23 volumio volumio[764]: info: ------------------------------ 1ms Jul 05 20:22:24 volumio volumio[764]: info: Jul 05 20:22:24 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:24 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:24 volumio volumio[764]: info: Jul 05 20:22:24 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:24 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:24 volumio volumio[764]: info: Jul 05 20:22:24 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:24 volumio volumio[764]: info: sendMpdCommand status took 5 milliseconds Jul 05 20:22:24 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:24 volumio volumio[764]: info: sendMpdCommand status took 5 milliseconds Jul 05 20:22:24 volumio volumio[764]: info: sendMpdCommand status took 1 milliseconds Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:24 volumio volumio[764]: info: Jul 05 20:22:24 volumio volumio[764]: ---------------------------- MPD announces state update: player Jul 05 20:22:24 volumio volumio[764]: info: ControllerMpd::getState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand status Jul 05 20:22:24 volumio volumio[764]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 05 20:22:24 volumio volumio[764]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 20:22:24 volumio volumio[764]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:24 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:24 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:24 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"看人生","artist":"阿吉仔","album":"再显奇迹","uri":"USB/music/阿吉仔 - 看人生.mp3","trackType":"mp3"} Jul 05 20:22:24 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus stop Jul 05 20:22:24 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:24 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:24 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"看人生","artist":"阿吉仔","album":"再显奇迹","uri":"USB/music/阿吉仔 - 看人生.mp3","trackType":"mp3"} Jul 05 20:22:24 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:24 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:24 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:24 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:24 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:24 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:24 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"看人生","artist":"阿吉仔","album":"再显奇迹","uri":"USB/music/阿吉仔 - 看人生.mp3","trackType":"mp3"} Jul 05 20:22:24 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:24 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:24 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:24 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:24 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:24 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:24 volumio volumio[764]: info: ------------------------------ 22ms Jul 05 20:22:24 volumio volumio[764]: info: ------------------------------ 36ms Jul 05 20:22:24 volumio volumio[764]: info: ------------------------------ 31ms Jul 05 20:22:24 volumio volumio[764]: info: sendMpdCommand status took 29 milliseconds Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::parseState Jul 05 20:22:24 volumio volumio[764]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 20:22:25 volumio volumio[764]: info: sendMpdCommand playlistinfo took 626 milliseconds Jul 05 20:22:25 volumio volumio[764]: verbose: ControllerMpd::parseTrackInfo Jul 05 20:22:25 volumio volumio[764]: info: ControllerMpd::pushState Jul 05 20:22:25 volumio volumio[764]: info: CoreCommandRouter::servicePushState Jul 05 20:22:25 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:25 volumio volumio[764]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":252,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"看人生","artist":"阿吉仔","album":"再显奇迹","uri":"USB/music/阿吉仔 - 看人生.mp3","trackType":"mp3"} Jul 05 20:22:25 volumio volumio[764]: verbose: CURRENT POSITION 0 Jul 05 20:22:25 volumio volumio[764]: info: CoreStateMachine::syncState stateService play Jul 05 20:22:25 volumio volumio[764]: info: CoreStateMachine::syncState currentStatus play Jul 05 20:22:25 volumio volumio[764]: info: Received an update from plugin. extracting info from payload Jul 05 20:22:25 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:25 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:25 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 20:22:25 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:25 volumio volumio[764]: info: CoreStateMachine::pushState Jul 05 20:22:25 volumio volumio[764]: info: CorePlayQueue::getTrack 0 Jul 05 20:22:25 volumio volumio[764]: info: CoreCommandRouter::volumioPushState Jul 05 20:22:25 volumio volumio[764]: info: ------------------------------ 666ms Jul 05 20:22:27 volumio volumio[764]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 20:22:27 volumio volumio[764]: Error: connect ETIMEDOUT 150.107.3.176:80 Jul 05 20:22:27 volumio volumio[764]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 05 20:22:27 volumio volumio[764]: errno: -110, Jul 05 20:22:27 volumio volumio[764]: code: 'ETIMEDOUT', Jul 05 20:22:27 volumio volumio[764]: syscall: 'connect', Jul 05 20:22:27 volumio volumio[764]: address: '150.107.3.176', Jul 05 20:22:27 volumio volumio[764]: port: 80 Jul 05 20:22:27 volumio volumio[764]: } Jul 05 20:22:27 volumio volumio[764]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 20:22:27 volumio sudo[5774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-05 20:21 Jul 05 20:22:27 volumio sudo[5774]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"