-- Logs begin at Sat 2024-08-24 22:32:55 CST, end at Sat 2024-08-24 22:56:25 CST. -- Aug 24 22:55:13 volumio volumio[856]: info: Aug 24 22:55:13 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:13 volumio volumio[856]: info: Aug 24 22:55:13 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:13 volumio volumio[856]: info: Aug 24 22:55:13 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:13 volumio volumio[856]: info: Aug 24 22:55:13 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:13 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:13 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情难独奏","artist":"童丽","album":"情浓恨更浓","uri":"http://192.168.0.105:8602/file?sid=187.flac","trackType":"flac"} Aug 24 22:55:13 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:13 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情难独奏","artist":"童丽","album":"情浓恨更浓","uri":"http://192.168.0.105:8602/file?sid=187.flac","trackType":"flac"} Aug 24 22:55:13 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: No code Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:13 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情难独奏","artist":"童丽","album":"情浓恨更浓","uri":"http://192.168.0.105:8602/file?sid=187.flac","trackType":"flac"} Aug 24 22:55:13 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: No code Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:13 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"情难独奏","artist":"童丽","album":"情浓恨更浓","uri":"http://192.168.0.105:8602/file?sid=187.flac","trackType":"flac"} Aug 24 22:55:13 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: No code Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:13 volumio volumio[856]: info: ------------------------------ 18ms Aug 24 22:55:13 volumio volumio[856]: info: CoreCommandRouter::volumioGetQueue Aug 24 22:55:13 volumio volumio[856]: info: CoreStateMachine::getQueue Aug 24 22:55:13 volumio volumio[856]: info: CorePlayQueue::getQueue Aug 24 22:55:13 volumio sudo[6609]: pam_unix(sudo:session): session closed for user root Aug 24 22:55:13 volumio volumio[856]: info: Clearing queue after UPNP request Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::ClearQueue Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::stop Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 24 22:55:14 volumio volumio[856]: info: CorePlayQueue::clearPlayQueue Aug 24 22:55:14 volumio volumio[856]: info: CorePlayQueue::saveQueue Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: error: updateQueue error: null Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 3ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: Starting UPNP Playback Aug 24 22:55:14 volumio volumio[856]: info: Preparing playback through UPNP Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Aug 24 22:55:14 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:14 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 5ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 5ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 4ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 4ms Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 36 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 36 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 36 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 36 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:14 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:14 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:14 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:14 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:14 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:14 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:14 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:14 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:14 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:14 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:14 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:14 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:14 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:14 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:14 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 43ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 46ms Aug 24 22:55:14 volumio volumio[856]: info: ------------------------------ 45ms Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: info: Aug 24 22:55:14 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand playlistinfo took 42 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 30 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 8 milliseconds Aug 24 22:55:14 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:14 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:14 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:14 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:14 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:14 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:14 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:14 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:14 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:15 volumio volumio[856]: info: ------------------------------ 64ms Aug 24 22:55:15 volumio volumio[856]: info: sendMpdCommand playlistinfo took 54 milliseconds Aug 24 22:55:15 volumio volumio[856]: info: sendMpdCommand playlistinfo took 54 milliseconds Aug 24 22:55:15 volumio volumio[856]: info: sendMpdCommand playlistinfo took 55 milliseconds Aug 24 22:55:15 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:15 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:15 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:15 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:15 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:15 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:15 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:15 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:15 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:15 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:15 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":20,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:15 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:15 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:15 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:15 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:15 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":26,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:15 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:15 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:15 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:15 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:15 volumio volumio[856]: info: ------------------------------ 106ms Aug 24 22:55:15 volumio volumio[856]: info: ------------------------------ 83ms Aug 24 22:55:15 volumio volumio[856]: info: ------------------------------ 82ms Aug 24 22:55:24 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Aug 24 22:55:24 volumio sudo[7170]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Aug 24 22:55:24 volumio sudo[7170]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 22:55:26 volumio volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 6 Aug 24 22:55:26 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: No code Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: No code Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: No code Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 17ms Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 18ms Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 17ms Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 20ms Aug 24 22:55:41 volumio sudo[7170]: pam_unix(sudo:session): session closed for user root Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 5 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 5 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: Aug 24 22:55:41 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 8 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 6 milliseconds Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 36ms Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 42ms Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 40ms Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 39ms Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 35 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand status took 31 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 29 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 28 milliseconds Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 51ms Aug 24 22:55:41 volumio volumio[856]: info: ------------------------------ 49ms Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 25 milliseconds Aug 24 22:55:41 volumio volumio[856]: info: sendMpdCommand playlistinfo took 25 milliseconds Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:41 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:41 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:41 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:41 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:41 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:41 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:42 volumio volumio[856]: info: ------------------------------ 69ms Aug 24 22:55:42 volumio volumio[856]: info: ------------------------------ 66ms Aug 24 22:55:45 volumio volumio[856]: info: Aug 24 22:55:45 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:45 volumio volumio[856]: info: Aug 24 22:55:45 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:45 volumio volumio[856]: info: Aug 24 22:55:45 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:45 volumio volumio[856]: info: Aug 24 22:55:45 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:45 volumio volumio[856]: info: sendMpdCommand status took 5 milliseconds Aug 24 22:55:45 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds Aug 24 22:55:45 volumio volumio[856]: info: sendMpdCommand status took 0 milliseconds Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:45 volumio volumio[856]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 24 22:55:45 volumio volumio[856]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 24 22:55:45 volumio volumio[856]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 24 22:55:45 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:45 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:45 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::stPlaybackTimer Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:45 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:45 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: No code Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:45 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:45 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: No code Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:45 volumio volumio[856]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:45 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState stateService stop Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: No code Aug 24 22:55:45 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:45 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:45 volumio volumio[856]: info: ------------------------------ 25ms Aug 24 22:55:45 volumio volumio[856]: info: ------------------------------ 23ms Aug 24 22:55:45 volumio volumio[856]: info: ------------------------------ 22ms Aug 24 22:55:46 volumio volumio[856]: info: Clearing queue after UPNP request Aug 24 22:55:46 volumio volumio[856]: info: CoreStateMachine::ClearQueue Aug 24 22:55:46 volumio volumio[856]: info: CoreStateMachine::stop Aug 24 22:55:46 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 24 22:55:46 volumio volumio[856]: info: CorePlayQueue::clearPlayQueue Aug 24 22:55:46 volumio volumio[856]: info: CorePlayQueue::saveQueue Aug 24 22:55:46 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:46 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: error: updateQueue error: null Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:46 volumio volumio[856]: info: Starting UPNP Playback Aug 24 22:55:46 volumio volumio[856]: info: Preparing playback through UPNP Aug 24 22:55:46 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Aug 24 22:55:46 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Aug 24 22:55:46 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 3ms Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 3ms Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 3ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 3ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 3ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: Aug 24 22:55:46 volumio volumio[856]: ---------------------------- MPD announces system playlist update Aug 24 22:55:46 volumio volumio[856]: info: Ignoring MPD Status Update Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 2ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:46 volumio volumio[856]: info: ------------------------------ 1ms Aug 24 22:55:52 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Aug 24 22:55:52 volumio screensaver.sh[466]: 4320 4243 4106 3985 3797 2214 Aug 24 22:55:52 volumio volumio[856]: error: peppy_screensaver: Error start PeppyMeter: Error: Command failed: /data/plugins/user_interface/peppy_screensaver/run_peppymeter.sh Aug 24 22:55:52 volumio volumio[856]: No protocol specified Aug 24 22:55:52 volumio volumio[856]: Exception in thread Thread-4: Aug 24 22:55:52 volumio volumio[856]: Traceback (most recent call last): Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Aug 24 22:55:52 volumio volumio[856]: self.run() Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 865, in run Aug 24 22:55:52 volumio volumio[856]: self._target(*self._args, **self._kwargs) Aug 24 22:55:52 volumio volumio[856]: File "./screensaver/volumio_peppymeter.py", line 109, in meter_thread Aug 24 22:55:52 volumio volumio[856]: File "/data/plugins/user_interface/peppy_screensaver/screensaver/peppymeter/peppymeter.py", line 144, in init_display Aug 24 22:55:52 volumio volumio[856]: pygame.display.init() Aug 24 22:55:52 volumio volumio[856]: pygame.error: Unable to open a console terminal Aug 24 22:55:52 volumio volumio[856]: Terminated Aug 24 22:55:52 volumio volumio[856]: error: peppy_screensaver: Error start PeppyMeter: Error: Command failed: /data/plugins/user_interface/peppy_screensaver/run_peppymeter.sh Aug 24 22:55:52 volumio volumio[856]: No protocol specified Aug 24 22:55:52 volumio volumio[856]: Exception in thread Thread-4: Aug 24 22:55:52 volumio volumio[856]: Traceback (most recent call last): Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Aug 24 22:55:52 volumio volumio[856]: self.run() Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 865, in run Aug 24 22:55:52 volumio volumio[856]: self._target(*self._args, **self._kwargs) Aug 24 22:55:52 volumio volumio[856]: File "./screensaver/volumio_peppymeter.py", line 109, in meter_thread Aug 24 22:55:52 volumio volumio[856]: File "/data/plugins/user_interface/peppy_screensaver/screensaver/peppymeter/peppymeter.py", line 144, in init_display Aug 24 22:55:52 volumio volumio[856]: pygame.display.init() Aug 24 22:55:52 volumio volumio[856]: pygame.error: Unable to open a console terminal Aug 24 22:55:52 volumio volumio[856]: Terminated Aug 24 22:55:52 volumio volumio[856]: error: peppy_screensaver: Error start PeppyMeter: Error: Command failed: /data/plugins/user_interface/peppy_screensaver/run_peppymeter.sh Aug 24 22:55:52 volumio volumio[856]: No protocol specified Aug 24 22:55:52 volumio volumio[856]: Exception in thread Thread-4: Aug 24 22:55:52 volumio volumio[856]: Traceback (most recent call last): Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Aug 24 22:55:52 volumio volumio[856]: self.run() Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 865, in run Aug 24 22:55:52 volumio volumio[856]: self._target(*self._args, **self._kwargs) Aug 24 22:55:52 volumio volumio[856]: File "./screensaver/volumio_peppymeter.py", line 109, in meter_thread Aug 24 22:55:52 volumio volumio[856]: File "/data/plugins/user_interface/peppy_screensaver/screensaver/peppymeter/peppymeter.py", line 144, in init_display Aug 24 22:55:52 volumio volumio[856]: pygame.display.init() Aug 24 22:55:52 volumio volumio[856]: pygame.error: Unable to open a console terminal Aug 24 22:55:52 volumio volumio[856]: Terminated Aug 24 22:55:52 volumio volumio[856]: error: peppy_screensaver: Error start PeppyMeter: Error: Command failed: /data/plugins/user_interface/peppy_screensaver/run_peppymeter.sh Aug 24 22:55:52 volumio volumio[856]: No protocol specified Aug 24 22:55:52 volumio volumio[856]: Exception in thread Thread-4: Aug 24 22:55:52 volumio volumio[856]: Traceback (most recent call last): Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Aug 24 22:55:52 volumio volumio[856]: self.run() Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 865, in run Aug 24 22:55:52 volumio volumio[856]: self._target(*self._args, **self._kwargs) Aug 24 22:55:52 volumio volumio[856]: File "./screensaver/volumio_peppymeter.py", line 109, in meter_thread Aug 24 22:55:52 volumio volumio[856]: File "/data/plugins/user_interface/peppy_screensaver/screensaver/peppymeter/peppymeter.py", line 144, in init_display Aug 24 22:55:52 volumio volumio[856]: pygame.display.init() Aug 24 22:55:52 volumio volumio[856]: pygame.error: Unable to open a console terminal Aug 24 22:55:52 volumio volumio[856]: Terminated Aug 24 22:55:52 volumio volumio[856]: error: peppy_screensaver: Error start PeppyMeter: Error: Command failed: /data/plugins/user_interface/peppy_screensaver/run_peppymeter.sh Aug 24 22:55:52 volumio volumio[856]: No protocol specified Aug 24 22:55:52 volumio volumio[856]: Exception in thread Thread-4: Aug 24 22:55:52 volumio volumio[856]: Traceback (most recent call last): Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Aug 24 22:55:52 volumio volumio[856]: self.run() Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 865, in run Aug 24 22:55:52 volumio volumio[856]: self._target(*self._args, **self._kwargs) Aug 24 22:55:52 volumio volumio[856]: File "./screensaver/volumio_peppymeter.py", line 109, in meter_thread Aug 24 22:55:52 volumio volumio[856]: File "/data/plugins/user_interface/peppy_screensaver/screensaver/peppymeter/peppymeter.py", line 144, in init_display Aug 24 22:55:52 volumio volumio[856]: pygame.display.init() Aug 24 22:55:52 volumio volumio[856]: pygame.error: Unable to open a console terminal Aug 24 22:55:52 volumio volumio[856]: Terminated Aug 24 22:55:52 volumio volumio[856]: error: peppy_screensaver: Error start PeppyMeter: Error: Command failed: /data/plugins/user_interface/peppy_screensaver/run_peppymeter.sh Aug 24 22:55:52 volumio volumio[856]: No protocol specified Aug 24 22:55:52 volumio volumio[856]: Exception in thread Thread-4: Aug 24 22:55:52 volumio volumio[856]: Traceback (most recent call last): Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Aug 24 22:55:52 volumio volumio[856]: self.run() Aug 24 22:55:52 volumio volumio[856]: File "/usr/lib/python3.7/threading.py", line 865, in run Aug 24 22:55:52 volumio volumio[856]: self._target(*self._args, **self._kwargs) Aug 24 22:55:52 volumio volumio[856]: File "./screensaver/volumio_peppymeter.py", line 109, in meter_thread Aug 24 22:55:52 volumio volumio[856]: File "/data/plugins/user_interface/peppy_screensaver/screensaver/peppymeter/peppymeter.py", line 144, in init_display Aug 24 22:55:52 volumio volumio[856]: pygame.display.init() Aug 24 22:55:52 volumio volumio[856]: pygame.error: Unable to open a console terminal Aug 24 22:55:52 volumio volumio[856]: Terminated Aug 24 22:55:52 volumio volumio[856]: info: Aug 24 22:55:52 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:52 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:52 volumio volumio[856]: info: Aug 24 22:55:52 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:52 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:52 volumio volumio[856]: info: Aug 24 22:55:52 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:52 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:52 volumio volumio[856]: info: Aug 24 22:55:52 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:52 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:52 volumio volumio[856]: info: Aug 24 22:55:52 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:52 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds Aug 24 22:55:52 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds Aug 24 22:55:52 volumio volumio[856]: info: sendMpdCommand status took 3 milliseconds Aug 24 22:55:52 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:52 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand status took 3 milliseconds Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand status took 1 milliseconds Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus stop Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:53 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:53 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: ------------------------------ 12ms Aug 24 22:55:53 volumio volumio[856]: info: ------------------------------ 13ms Aug 24 22:55:53 volumio volumio[856]: info: Aug 24 22:55:53 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:53 volumio volumio[856]: info: Aug 24 22:55:53 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:53 volumio volumio[856]: info: Aug 24 22:55:53 volumio volumio[856]: ---------------------------- MPD announces state update: player Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::getState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand status Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand status took 2 milliseconds Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:53 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:53 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: ------------------------------ 27ms Aug 24 22:55:53 volumio volumio[856]: info: ------------------------------ 26ms Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand status took 30 milliseconds Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand playlistinfo took 29 milliseconds Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseState Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:53 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:53 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: ------------------------------ 158ms Aug 24 22:55:53 volumio volumio[856]: info: ------------------------------ 157ms Aug 24 22:55:53 volumio volumio[856]: info: sendMpdCommand playlistinfo took 127 milliseconds Aug 24 22:55:53 volumio volumio[856]: verbose: ControllerMpd::parseTrackInfo Aug 24 22:55:53 volumio volumio[856]: info: ControllerMpd::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::servicePushState Aug 24 22:55:53 volumio volumio[856]: verbose: In UPNP mode Aug 24 22:55:53 volumio volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"96 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知歌手 - 01 古老的故事","artist":"未知歌手","album":null,"uri":"http://192.168.0.105:8602/file?sid=33.wav","trackType":"wav"} Aug 24 22:55:53 volumio volumio[856]: verbose: CURRENT POSITION 0 Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState stateService play Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::syncState currentStatus play Aug 24 22:55:53 volumio volumio[856]: info: Received an update from plugin. extracting info from payload Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: CoreStateMachine::pushState Aug 24 22:55:53 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Aug 24 22:55:53 volumio volumio[856]: info: ------------------------------ 168ms Aug 24 22:56:03 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Aug 24 22:56:03 volumio sudo[7523]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Aug 24 22:56:03 volumio sudo[7523]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 24 22:56:05 volumio volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 6 Aug 24 22:56:05 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Aug 24 22:56:25 volumio volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 22:56:25 volumio volumio[856]: Error: connect ETIMEDOUT 69.63.180.173:443 Aug 24 22:56:25 volumio volumio[856]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 24 22:56:25 volumio volumio[856]: errno: -110, Aug 24 22:56:25 volumio volumio[856]: code: 'ETIMEDOUT', Aug 24 22:56:25 volumio volumio[856]: syscall: 'connect', Aug 24 22:56:25 volumio volumio[856]: address: '69.63.180.173', Aug 24 22:56:25 volumio volumio[856]: port: 443 Aug 24 22:56:25 volumio volumio[856]: } Aug 24 22:56:25 volumio volumio[856]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 24 22:56:25 volumio sudo[7705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-24 22:55 Aug 24 22:56:25 volumio sudo[7705]: 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"