-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2025-02-17 16:02:45 CST. -- Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::pause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::stPlaybackTimer Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::servicePause Feb 17 16:01:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::servicePause Feb 17 16:01:08 volumio volumio[1005]: info: ControllerMpd::pause Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand pause Feb 17 16:01:08 volumio volumio[1005]: info: sendMpdCommand pause took 2 milliseconds Feb 17 16:01:08 volumio volumio[1005]: info: Feb 17 16:01:08 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:08 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:08 volumio volumio[1005]: info: Feb 17 16:01:08 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:08 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:08 volumio volumio[1005]: info: Feb 17 16:01:08 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:08 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:08 volumio volumio[1005]: info: sendMpdCommand status took 2 milliseconds Feb 17 16:01:08 volumio volumio[1005]: info: sendMpdCommand status took 2 milliseconds Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:08 volumio volumio[1005]: info: sendMpdCommand status took 2 milliseconds Feb 17 16:01:08 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 17 16:01:08 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:08 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:08 volumio volumio[1005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":40377,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Bad","artist":"Michael Jackson","album":"Bad","uri":"USB/09C1B27DA5EB573A/Michael Jackson 迈克杰克逊/01. Michael Jackson - Bad.flac","trackType":"flac"} Feb 17 16:01:08 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::syncState stateService pause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus pause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::stPlaybackTimer Feb 17 16:01:08 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:08 volumio volumio[1005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":40377,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Bad","artist":"Michael Jackson","album":"Bad","uri":"USB/09C1B27DA5EB573A/Michael Jackson 迈克杰克逊/01. Michael Jackson - Bad.flac","trackType":"flac"} Feb 17 16:01:08 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::syncState stateService pause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus pause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::stPlaybackTimer Feb 17 16:01:08 volumio volumio[1005]: info: ------------------------------ 18ms Feb 17 16:01:08 volumio volumio[1005]: info: ------------------------------ 17ms Feb 17 16:01:08 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 14 milliseconds Feb 17 16:01:08 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:08 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:08 volumio volumio[1005]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":40377,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Bad","artist":"Michael Jackson","album":"Bad","uri":"USB/09C1B27DA5EB573A/Michael Jackson 迈克杰克逊/01. Michael Jackson - Bad.flac","trackType":"flac"} Feb 17 16:01:08 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::syncState stateService pause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus pause Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:08 volumio volumio[1005]: info: CoreStateMachine::stPlaybackTimer Feb 17 16:01:08 volumio volumio[1005]: info: ------------------------------ 24ms Feb 17 16:01:12 volumio volumio[1005]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 17 16:01:13 volumio volumio[1005]: info: Getting Alsa Cards List without I2S DAC Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 17 16:01:13 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 17 16:01:18 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 16:01:18 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 16:01:18 volumio volumio[1005]: info: Discovery: Getting this device information Feb 17 16:01:18 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Feb 17 16:01:18 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:18 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 16:01:29 volumio volumio[1005]: info: Preload queue cleared Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::ClearQueue Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::stop Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::updateTrackBlock Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrackBlock Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::stPlaybackTimer Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::serviceStop Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::serviceStop Feb 17 16:01:29 volumio volumio[1005]: info: ControllerMpd::stop Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::clearPlayQueue Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::saveQueue Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushQueue Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::addQueueItems Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::addQueueItems Feb 17 16:01:29 volumio volumio[1005]: info: Preload queue cleared Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushQueue Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::saveQueue Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::updateTrackBlock Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrackBlock Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPlay Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::play index 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::addQueueItems Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::addQueueItems Feb 17 16:01:29 volumio volumio[1005]: info: Preload queue cleared Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/02. Track02.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/02. Track02.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/03. Track03.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/03. Track03.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/04. Track04.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/04. Track04.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/05. Track05.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/05. Track05.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/06. Track06.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/06. Track06.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/07. Track07.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/07. Track07.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/08. Track08.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/08. Track08.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/09. Track09.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/09. Track09.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/10. Track10.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/10. Track10.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/11. Track11.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/11. Track11.wav Feb 17 16:01:29 volumio volumio[1005]: info: Adding Item to queue: music-library/USB/09C1B27DA5EB573A/Philips试音碟/12. Track12.wav Feb 17 16:01:29 volumio volumio[1005]: info: Using cached record of: music-library/USB/09C1B27DA5EB573A/Philips试音碟/12. Track12.wav Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::stop Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushQueue Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::saveQueue Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::play index undefined Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::updateTrackBlock Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrackBlock Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::startPlaybackTimer Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::clearAddPlayTracks USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand stop took 18 milliseconds Feb 17 16:01:29 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand stop took 3 milliseconds Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:29 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:29 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Feb 17 16:01:29 volumio volumio[1005]: info: Ignoring MPD Status Update Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand status took 3 milliseconds Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand clear took 2 milliseconds Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand status took 2 milliseconds Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand status took 1 milliseconds Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand add "USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav" Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:29 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: 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} Feb 17 16:01:29 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::syncState stateService stop Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus stop Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:29 volumio volumio[1005]: info: No code Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:29 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: 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} Feb 17 16:01:29 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::syncState stateService stop Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus stop Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:29 volumio volumio[1005]: info: No code Feb 17 16:01:29 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:29 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:29 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 31ms Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 30ms Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Feb 17 16:01:29 volumio volumio[1005]: info: Ignoring MPD Status Update Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Feb 17 16:01:29 volumio volumio[1005]: info: Ignoring MPD Status Update Feb 17 16:01:29 volumio volumio[1005]: error: updateQueue error: null Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Feb 17 16:01:29 volumio volumio[1005]: info: Ignoring MPD Status Update Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 32ms Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand add "USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav" took 31 milliseconds Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 2ms Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:29 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand play Feb 17 16:01:29 volumio volumio[1005]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 36ms Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Feb 17 16:01:29 volumio volumio[1005]: info: Ignoring MPD Status Update Feb 17 16:01:29 volumio volumio[1005]: info: Feb 17 16:01:29 volumio volumio[1005]: ---------------------------- MPD announces system playlist update Feb 17 16:01:29 volumio volumio[1005]: info: Ignoring MPD Status Update Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 6ms Feb 17 16:01:29 volumio volumio[1005]: info: sendMpdCommand play took 6 milliseconds Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 6ms Feb 17 16:01:29 volumio volumio[1005]: info: ------------------------------ 5ms Feb 17 16:01:32 volumio volumio[1005]: info: Feb 17 16:01:32 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:32 volumio volumio[1005]: info: Feb 17 16:01:32 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:32 volumio volumio[1005]: info: Feb 17 16:01:32 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:32 volumio volumio[1005]: info: Feb 17 16:01:32 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand status took 4 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand status took 4 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand status took 3 milliseconds Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:32 volumio volumio[1005]: info: Feb 17 16:01:32 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:32 volumio volumio[1005]: info: Feb 17 16:01:32 volumio volumio[1005]: ---------------------------- MPD announces state update: player Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::getState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand status Feb 17 16:01:32 volumio volumio[1005]: Upnp client error: Error: This socket has been ended by the other party Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand status took 5 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand status took 4 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand status took 4 milliseconds Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseState Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01","artist":"?????","album":"????","uri":"USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav","trackType":"wav"} Feb 17 16:01:32 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus stop Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01","artist":"?????","album":"????","uri":"USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav","trackType":"wav"} Feb 17 16:01:32 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus play Feb 17 16:01:32 volumio volumio[1005]: info: Received an update from plugin. extracting info from payload Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01","artist":"?????","album":"????","uri":"USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav","trackType":"wav"} Feb 17 16:01:32 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus play Feb 17 16:01:32 volumio volumio[1005]: info: Received an update from plugin. extracting info from payload Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: ------------------------------ 22ms Feb 17 16:01:32 volumio volumio[1005]: info: ------------------------------ 33ms Feb 17 16:01:32 volumio volumio[1005]: info: ------------------------------ 33ms Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 36 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 35 milliseconds Feb 17 16:01:32 volumio volumio[1005]: info: sendMpdCommand playlistinfo took 35 milliseconds Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:32 volumio volumio[1005]: verbose: ControllerMpd::parseTrackInfo Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01","artist":"?????","album":"????","uri":"USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav","trackType":"wav"} Feb 17 16:01:32 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus play Feb 17 16:01:32 volumio volumio[1005]: info: Received an update from plugin. extracting info from payload Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01","artist":"?????","album":"????","uri":"USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav","trackType":"wav"} Feb 17 16:01:32 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus play Feb 17 16:01:32 volumio volumio[1005]: info: Received an update from plugin. extracting info from payload Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: ControllerMpd::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track01","artist":"?????","album":"????","uri":"USB/09C1B27DA5EB573A/Philips试音碟/01. Track01.wav","trackType":"wav"} Feb 17 16:01:32 volumio volumio[1005]: verbose: CURRENT POSITION 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState stateService play Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::syncState currentStatus play Feb 17 16:01:32 volumio volumio[1005]: info: Received an update from plugin. extracting info from payload Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: CoreStateMachine::pushState Feb 17 16:01:32 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:32 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Feb 17 16:01:32 volumio volumio[1005]: info: ------------------------------ 78ms Feb 17 16:01:32 volumio volumio[1005]: info: ------------------------------ 77ms Feb 17 16:01:32 volumio volumio[1005]: info: ------------------------------ 76ms Feb 17 16:01:48 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 16:01:48 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 16:01:48 volumio volumio[1005]: info: Discovery: Getting this device information Feb 17 16:01:48 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Feb 17 16:01:48 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:01:48 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 16:02:18 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 16:02:18 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 16:02:18 volumio volumio[1005]: info: Discovery: Getting this device information Feb 17 16:02:18 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Feb 17 16:02:18 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Feb 17 16:02:18 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 16:02:44 volumio volumio[1005]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 16:02:44 volumio volumio[1005]: Error: connect ETIMEDOUT 108.160.166.61:443 Feb 17 16:02:44 volumio volumio[1005]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Feb 17 16:02:44 volumio volumio[1005]: errno: -110, Feb 17 16:02:44 volumio volumio[1005]: code: 'ETIMEDOUT', Feb 17 16:02:44 volumio volumio[1005]: syscall: 'connect', Feb 17 16:02:44 volumio volumio[1005]: address: '108.160.166.61', Feb 17 16:02:44 volumio volumio[1005]: port: 443 Feb 17 16:02:44 volumio volumio[1005]: } Feb 17 16:02:44 volumio volumio[1005]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 16:02:45 volumio sudo[23533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-17 16:01 Feb 17 16:02:45 volumio sudo[23533]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"