-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2025-03-01 11:50:51 CET. -- Mar 01 11:49:01 volumio volumio[1409]: info: Mar 01 11:49:01 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:01 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:01 volumio volumio[1409]: info: Mar 01 11:49:01 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:01 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:01 volumio volumio[1409]: info: Mar 01 11:49:01 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:01 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:01 volumio volumio[1409]: info: Mar 01 11:49:01 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:01 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:01 volumio volumio[1409]: info: Mar 01 11:49:01 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:01 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:01 volumio volumio[1409]: info: Mar 01 11:49:01 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:01 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:01 volumio volumio[1409]: info: ------------------------------ 7ms Mar 01 11:49:01 volumio volumio[1409]: info: sendMpdCommand status took 6 milliseconds Mar 01 11:49:01 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:49:01 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:49:01 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:01 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:01 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:49:01 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:49:01 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:01 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:01 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:01 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":275777,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:01 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:01 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:01 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:01 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":275777,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:01 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:01 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:01 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:01 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":275777,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:01 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:01 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:01 volumio volumio[1409]: info: ------------------------------ 43ms Mar 01 11:49:01 volumio volumio[1409]: info: ------------------------------ 43ms Mar 01 11:49:01 volumio volumio[1409]: info: ------------------------------ 40ms Mar 01 11:49:04 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 01 11:49:04 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 01 11:49:04 volumio sudo[5414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 01 11:49:04 volumio sudo[5414]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:49:06 volumio sudo[5414]: pam_unix(sudo:session): session closed for user root Mar 01 11:49:07 volumio volumio[1409]: info: Mar 01 11:49:07 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:07 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:07 volumio volumio[1409]: info: Mar 01 11:49:07 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:07 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:07 volumio volumio[1409]: info: Mar 01 11:49:07 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:07 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:07 volumio volumio[1409]: info: Mar 01 11:49:07 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:07 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:07 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:49:07 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:49:07 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:07 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:07 volumio volumio[1409]: info: Mar 01 11:49:07 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:07 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:07 volumio volumio[1409]: info: Mar 01 11:49:07 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:07 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:07 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:07 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:07 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:07 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:07 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:07 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":281978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:07 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:07 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:07 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:07 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":281978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:07 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:07 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:07 volumio volumio[1409]: info: ------------------------------ 32ms Mar 01 11:49:07 volumio volumio[1409]: info: ------------------------------ 32ms Mar 01 11:49:07 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 27 milliseconds Mar 01 11:49:07 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:07 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:07 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":281978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:07 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:07 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:07 volumio volumio[1409]: info: ------------------------------ 42ms Mar 01 11:49:11 volumio volumio[1409]: info: Mar 01 11:49:11 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:11 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:11 volumio volumio[1409]: info: Mar 01 11:49:11 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:11 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:11 volumio volumio[1409]: info: Mar 01 11:49:11 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:11 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:11 volumio volumio[1409]: info: Mar 01 11:49:11 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:11 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:11 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:11 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:49:11 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:11 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:11 volumio volumio[1409]: info: Mar 01 11:49:11 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:11 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:11 volumio volumio[1409]: info: Mar 01 11:49:11 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:11 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:11 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 01 11:49:11 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 01 11:49:11 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:49:11 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:11 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:11 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:11 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:11 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:11 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:11 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:11 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:11 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:11 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:11 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:11 volumio volumio[1409]: info: ------------------------------ 30ms Mar 01 11:49:11 volumio volumio[1409]: info: ------------------------------ 30ms Mar 01 11:49:11 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 01 11:49:11 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:11 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:11 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:11 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:11 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:11 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:11 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:11 volumio volumio[1409]: info: ------------------------------ 39ms Mar 01 11:49:13 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 01 11:49:13 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 01 11:49:13 volumio sudo[5441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 01 11:49:13 volumio sudo[5441]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:49:15 volumio sudo[5441]: pam_unix(sudo:session): session closed for user root Mar 01 11:49:16 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 01 11:49:16 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 01 11:49:16 volumio sudo[5466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 01 11:49:16 volumio sudo[5466]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:49:16 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 01 11:49:16 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 01 11:49:16 volumio sudo[5473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 01 11:49:16 volumio sudo[5473]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:49:17 volumio sudo[5466]: pam_unix(sudo:session): session closed for user root Mar 01 11:49:17 volumio sudo[5473]: pam_unix(sudo:session): session closed for user root Mar 01 11:49:18 volumio volumio[1409]: info: Mar 01 11:49:18 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:18 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:18 volumio volumio[1409]: info: Mar 01 11:49:18 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:18 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:18 volumio volumio[1409]: info: Mar 01 11:49:18 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:18 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:18 volumio volumio[1409]: info: Mar 01 11:49:18 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:18 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:18 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:49:18 volumio volumio[1409]: info: sendMpdCommand status took 5 milliseconds Mar 01 11:49:18 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:49:18 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:18 volumio volumio[1409]: info: Mar 01 11:49:18 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:18 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:18 volumio volumio[1409]: info: Mar 01 11:49:18 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:18 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:18 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:18 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:18 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:18 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:18 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:18 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":292987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:18 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:18 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:18 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:18 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":292987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:18 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:18 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:18 volumio volumio[1409]: info: ------------------------------ 29ms Mar 01 11:49:18 volumio volumio[1409]: info: ------------------------------ 27ms Mar 01 11:49:18 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 01 11:49:18 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:18 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:18 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":292987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:18 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:18 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:18 volumio volumio[1409]: info: ------------------------------ 39ms Mar 01 11:49:24 volumio volumio[1409]: info: Mar 01 11:49:24 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:24 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:24 volumio volumio[1409]: info: Mar 01 11:49:24 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:24 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:24 volumio volumio[1409]: info: Mar 01 11:49:24 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:24 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:24 volumio volumio[1409]: info: Mar 01 11:49:24 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:24 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:24 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:49:24 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:49:24 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:24 volumio volumio[1409]: info: Mar 01 11:49:24 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:24 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:24 volumio volumio[1409]: info: Mar 01 11:49:24 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:24 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:24 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:49:24 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:24 volumio volumio[1409]: info: ------------------------------ 1ms Mar 01 11:49:24 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:24 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:24 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:24 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":299279,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:24 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:24 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:24 volumio volumio[1409]: info: ------------------------------ 18ms Mar 01 11:49:24 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 01 11:49:24 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:24 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:24 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:24 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:24 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":299279,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:24 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:24 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:24 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:24 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:24 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":299279,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:24 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:24 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:24 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:24 volumio volumio[1409]: info: ------------------------------ 43ms Mar 01 11:49:24 volumio volumio[1409]: info: ------------------------------ 41ms Mar 01 11:49:30 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 01 11:49:30 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 01 11:49:30 volumio sudo[5506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 01 11:49:30 volumio sudo[5506]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:49:31 volumio volumio[1409]: info: Mar 01 11:49:31 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:31 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:31 volumio volumio[1409]: info: Mar 01 11:49:31 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:31 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:31 volumio volumio[1409]: info: Mar 01 11:49:31 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:31 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:31 volumio volumio[1409]: info: Mar 01 11:49:31 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:31 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:31 volumio volumio[1409]: info: Mar 01 11:49:31 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:31 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:31 volumio volumio[1409]: info: Mar 01 11:49:31 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:31 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:31 volumio volumio[1409]: info: ------------------------------ 6ms Mar 01 11:49:31 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:49:31 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:49:31 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:49:31 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:31 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:31 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 01 11:49:31 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 01 11:49:31 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:31 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:31 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:31 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":305982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:31 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:31 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:31 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:31 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":305982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:31 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:31 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:31 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:31 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":305982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:31 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:31 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:31 volumio volumio[1409]: info: ------------------------------ 59ms Mar 01 11:49:31 volumio volumio[1409]: info: ------------------------------ 56ms Mar 01 11:49:31 volumio volumio[1409]: info: ------------------------------ 56ms Mar 01 11:49:32 volumio sudo[5506]: pam_unix(sudo:session): session closed for user root Mar 01 11:49:35 volumio volumio[1409]: info: Mar 01 11:49:35 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:35 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:35 volumio volumio[1409]: info: Mar 01 11:49:35 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:35 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:35 volumio volumio[1409]: info: Mar 01 11:49:35 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:35 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:35 volumio volumio[1409]: info: Mar 01 11:49:35 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:35 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:35 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:49:35 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:49:35 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:35 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:35 volumio volumio[1409]: info: Mar 01 11:49:35 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:35 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:35 volumio volumio[1409]: info: Mar 01 11:49:35 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:35 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:35 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:35 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:35 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:35 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:35 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:35 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:35 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":310582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:35 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:35 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:35 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:35 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:35 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":310582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:35 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:35 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:35 volumio volumio[1409]: info: ------------------------------ 53ms Mar 01 11:49:35 volumio volumio[1409]: info: ------------------------------ 53ms Mar 01 11:49:35 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 48 milliseconds Mar 01 11:49:35 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:35 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:35 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:35 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":310582,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:35 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:35 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:35 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:35 volumio volumio[1409]: info: ------------------------------ 84ms Mar 01 11:49:42 volumio volumio[1409]: info: Mar 01 11:49:42 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:42 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:42 volumio volumio[1409]: info: Mar 01 11:49:42 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:42 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:42 volumio volumio[1409]: info: Mar 01 11:49:42 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:42 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:42 volumio volumio[1409]: info: Mar 01 11:49:42 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:42 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:42 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:49:42 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:49:42 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:42 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:42 volumio volumio[1409]: info: Mar 01 11:49:42 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:42 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:42 volumio volumio[1409]: info: Mar 01 11:49:42 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:42 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:42 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:42 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:42 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:42 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:42 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:42 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:42 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":316982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:42 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:42 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:42 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:42 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:42 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":316982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:42 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:42 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:42 volumio volumio[1409]: info: ------------------------------ 27ms Mar 01 11:49:42 volumio volumio[1409]: info: ------------------------------ 26ms Mar 01 11:49:42 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 01 11:49:42 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:42 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:42 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:42 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":316982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:42 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:42 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:42 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:42 volumio volumio[1409]: info: ------------------------------ 40ms Mar 01 11:49:43 volumio volumio[1409]: info: Mar 01 11:49:43 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:43 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:43 volumio volumio[1409]: info: Mar 01 11:49:43 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:43 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:43 volumio volumio[1409]: info: Mar 01 11:49:43 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:43 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:43 volumio volumio[1409]: info: Mar 01 11:49:43 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:43 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:43 volumio volumio[1409]: info: Mar 01 11:49:43 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:43 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:43 volumio volumio[1409]: info: Mar 01 11:49:43 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:43 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:43 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:49:43 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:49:43 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:49:43 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:49:43 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:43 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:43 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:49:43 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:49:43 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:43 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:43 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:43 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":318577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:43 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:43 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:43 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:43 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":318577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:43 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:43 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:43 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:43 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":318577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:43 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:43 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:43 volumio volumio[1409]: info: ------------------------------ 37ms Mar 01 11:49:43 volumio volumio[1409]: info: ------------------------------ 36ms Mar 01 11:49:43 volumio volumio[1409]: info: ------------------------------ 36ms Mar 01 11:49:48 volumio volumio[1409]: info: Mar 01 11:49:48 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:48 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:48 volumio volumio[1409]: info: Mar 01 11:49:48 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:48 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:48 volumio volumio[1409]: info: Mar 01 11:49:48 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:48 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:48 volumio volumio[1409]: info: Mar 01 11:49:48 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:48 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:48 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:49:48 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:49:48 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:49:48 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:48 volumio volumio[1409]: info: Mar 01 11:49:48 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:48 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:48 volumio volumio[1409]: info: Mar 01 11:49:48 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:48 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:48 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:48 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:48 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:49:48 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:48 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:48 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:48 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":323386,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:48 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:48 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:48 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:48 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:48 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":323386,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:48 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:48 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:48 volumio volumio[1409]: info: ------------------------------ 30ms Mar 01 11:49:48 volumio volumio[1409]: info: ------------------------------ 29ms Mar 01 11:49:48 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 26 milliseconds Mar 01 11:49:48 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:48 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:48 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:48 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":323386,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:48 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:48 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:48 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:48 volumio volumio[1409]: info: ------------------------------ 42ms Mar 01 11:49:54 volumio volumio[1409]: info: Mar 01 11:49:54 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:54 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:54 volumio volumio[1409]: info: Mar 01 11:49:54 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:54 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:54 volumio volumio[1409]: info: Mar 01 11:49:54 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:54 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:54 volumio volumio[1409]: info: Mar 01 11:49:54 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:54 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:54 volumio volumio[1409]: info: Mar 01 11:49:54 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:49:54 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:49:54 volumio volumio[1409]: info: Mar 01 11:49:54 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:49:54 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:49:54 volumio volumio[1409]: info: ------------------------------ 8ms Mar 01 11:49:54 volumio volumio[1409]: info: sendMpdCommand status took 7 milliseconds Mar 01 11:49:54 volumio volumio[1409]: info: ------------------------------ 6ms Mar 01 11:49:54 volumio volumio[1409]: info: sendMpdCommand status took 6 milliseconds Mar 01 11:49:54 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:54 volumio volumio[1409]: info: sendMpdCommand status took 8 milliseconds Mar 01 11:49:54 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:54 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:54 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:54 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:54 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":329578,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:54 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:54 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:54 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:54 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:54 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":329578,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:54 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:54 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:54 volumio volumio[1409]: info: ------------------------------ 37ms Mar 01 11:49:54 volumio volumio[1409]: info: ------------------------------ 37ms Mar 01 11:49:54 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 01 11:49:54 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:49:54 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:49:54 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:54 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":329578,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:49:54 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:49:54 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:49:54 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:49:54 volumio volumio[1409]: info: ------------------------------ 49ms Mar 01 11:50:01 volumio volumio[1409]: info: Mar 01 11:50:01 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:01 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:01 volumio volumio[1409]: info: Mar 01 11:50:01 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:01 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:01 volumio volumio[1409]: info: Mar 01 11:50:01 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:01 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:01 volumio volumio[1409]: info: Mar 01 11:50:01 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:01 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:01 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:01 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:01 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:50:01 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:01 volumio volumio[1409]: info: Mar 01 11:50:01 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:01 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:01 volumio volumio[1409]: info: Mar 01 11:50:01 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:01 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:01 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:01 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:01 volumio volumio[1409]: info: ------------------------------ 1ms Mar 01 11:50:01 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:01 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:01 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":336280,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:01 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:01 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:01 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:01 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":336280,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:01 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:01 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:01 volumio volumio[1409]: info: ------------------------------ 27ms Mar 01 11:50:01 volumio volumio[1409]: info: ------------------------------ 27ms Mar 01 11:50:01 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 01 11:50:01 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:01 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:01 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":336280,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:01 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:01 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:01 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:01 volumio volumio[1409]: info: ------------------------------ 43ms Mar 01 11:50:03 volumio volumio[1409]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Mar 01 11:50:03 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Mar 01 11:50:03 volumio sudo[5610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Mar 01 11:50:03 volumio sudo[5610]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:03 volumio sudo[5610]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:03 volumio sudo[5619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Mar 01 11:50:03 volumio sudo[5619]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:03 volumio sudo[5619]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:03 volumio volumio[1409]: info: Permissions for /etc/network/interfaces set Mar 01 11:50:03 volumio volumio[1409]: info: Restarting Wireless Network Mar 01 11:50:03 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Mar 01 11:50:03 volumio volumio[1409]: info: Discovery: Restarting Advertising due to device name change Mar 01 11:50:03 volumio sudo[5629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Mar 01 11:50:03 volumio sudo[5629]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:03 volumio wpa_supplicant[954]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Mar 01 11:50:03 volumio wpa_supplicant[954]: nl80211: Failed to set IPv4 unicast in multicast filter Mar 01 11:50:03 volumio systemd[1]: Stopping Wireless Services... Mar 01 11:50:03 volumio wpa_supplicant[954]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Mar 01 11:50:03 volumio wpa_supplicant[954]: nl80211: Failed to set IPv4 unicast in multicast filter Mar 01 11:50:03 volumio wpa_supplicant[954]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Mar 01 11:50:03 volumio wpa_supplicant[954]: wlan0: CTRL-EVENT-TERMINATING Mar 01 11:50:03 volumio systemd[1]: wireless.service: Succeeded. Mar 01 11:50:03 volumio systemd[1]: Stopped Wireless Services. Mar 01 11:50:03 volumio systemd[1]: Starting Wireless Services... Mar 01 11:50:04 volumio wireless.js[5635]: Cleaning previous... Mar 01 11:50:04 volumio sudo[5651]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 01 11:50:04 volumio sudo[5651]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:04 volumio sudo[5651]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:04 volumio sudo[5660]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 01 11:50:04 volumio sudo[5660]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:04 volumio sudo[5660]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:04 volumio wireless.js[5635]: Stopped aP Mar 01 11:50:04 volumio sudo[5674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 01 11:50:04 volumio sudo[5674]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:04 volumio sudo[5674]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:04 volumio sudo[5683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 01 11:50:04 volumio sudo[5683]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:04 volumio sudo[5683]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:04 volumio sudo[5697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 01 11:50:04 volumio sudo[5697]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:04 volumio sudo[5697]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:04 volumio sudo[5706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 01 11:50:04 volumio sudo[5706]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:04 volumio volumio[1409]: info: Discovery: A device disappeared from network Mar 01 11:50:04 volumio volumio[1409]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Mar 01 11:50:05 volumio sudo[5706]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:05 volumio wireless.js[5635]: Wireless Networking DISABLED, not starting wireless flow Mar 01 11:50:05 volumio iwconfig[5718]: Error for wireless request "Set Power Management" (8B2C) : Mar 01 11:50:05 volumio iwconfig[5718]: SET failed on device wlan0 ; Operation not permitted. Mar 01 11:50:05 volumio systemd[1]: wireless.service: Succeeded. Mar 01 11:50:05 volumio systemd[1]: Started Wireless Services. Mar 01 11:50:05 volumio sudo[5629]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:06 volumio volumio[1409]: info: Mar 01 11:50:06 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:06 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:06 volumio volumio[1409]: info: Mar 01 11:50:06 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:06 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:06 volumio volumio[1409]: info: Mar 01 11:50:06 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:06 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:06 volumio volumio[1409]: info: Mar 01 11:50:06 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:06 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:06 volumio volumio[1409]: info: Mar 01 11:50:06 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:06 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:06 volumio volumio[1409]: info: Mar 01 11:50:06 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:06 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:06 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:06 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:06 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:06 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:06 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:50:06 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:06 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:06 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:06 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:06 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:06 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:06 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:06 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":340881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:06 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:06 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:06 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:06 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:06 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":340881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:06 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:06 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:06 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:06 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:06 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":340881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:06 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:06 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:06 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:06 volumio volumio[1409]: info: ------------------------------ 39ms Mar 01 11:50:06 volumio volumio[1409]: info: ------------------------------ 37ms Mar 01 11:50:06 volumio volumio[1409]: info: ------------------------------ 37ms Mar 01 11:50:07 volumio volumio[1409]: info: Mar 01 11:50:07 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:07 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:07 volumio volumio[1409]: info: Mar 01 11:50:07 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:07 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:07 volumio volumio[1409]: info: Mar 01 11:50:07 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:07 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:07 volumio volumio[1409]: info: Mar 01 11:50:07 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:07 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:07 volumio volumio[1409]: info: Mar 01 11:50:07 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:07 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:07 volumio volumio[1409]: info: Mar 01 11:50:07 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:07 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:07 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:50:07 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:07 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:07 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:50:07 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:07 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:07 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:07 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:07 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:07 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:07 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:07 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342479,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:07 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:07 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:07 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:07 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342479,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:07 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:07 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:07 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:07 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342479,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:07 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:07 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:07 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:07 volumio volumio[1409]: info: ------------------------------ 37ms Mar 01 11:50:07 volumio volumio[1409]: info: ------------------------------ 36ms Mar 01 11:50:07 volumio volumio[1409]: info: ------------------------------ 34ms Mar 01 11:50:08 volumio volumio[1409]: info: Discovery: Started advertising with name: VOLUMIO Mar 01 11:50:09 volumio volumio[1409]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 01 11:50:10 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Mar 01 11:50:10 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Mar 01 11:50:10 volumio sudo[5742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 11:50:10 volumio sudo[5742]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:10 volumio sudo[5742]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:12 volumio volumio[1409]: info: Mar 01 11:50:12 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:12 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:12 volumio volumio[1409]: info: Mar 01 11:50:12 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:12 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:12 volumio volumio[1409]: info: Mar 01 11:50:12 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:12 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:12 volumio volumio[1409]: info: Mar 01 11:50:12 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:12 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:12 volumio volumio[1409]: info: Mar 01 11:50:12 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:12 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:12 volumio volumio[1409]: info: Mar 01 11:50:12 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:12 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:12 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:12 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:12 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:12 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:50:12 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:50:12 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:12 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:12 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:12 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:12 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:12 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:12 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:12 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":347688,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:12 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:12 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:12 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:12 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:12 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":347688,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:12 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:12 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:12 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:12 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:12 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":347688,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:12 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:12 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:12 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:12 volumio volumio[1409]: info: ------------------------------ 38ms Mar 01 11:50:12 volumio volumio[1409]: info: ------------------------------ 38ms Mar 01 11:50:12 volumio volumio[1409]: info: ------------------------------ 36ms Mar 01 11:50:15 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Mar 01 11:50:15 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Mar 01 11:50:15 volumio volumio[1409]: info: Refreshing Cached IP Addresses Mar 01 11:50:15 volumio sudo[5753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 11:50:15 volumio sudo[5755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 11:50:15 volumio sudo[5753]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:15 volumio sudo[5755]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:15 volumio sudo[5753]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:15 volumio sudo[5755]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:17 volumio volumio[1409]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 4 Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 01 11:50:18 volumio volumio[1409]: info: Received Get System Info Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 11:50:18 volumio volumio[1409]: info: Discovery: Getting this device information Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:18 volumio volumio[1409]: info: Listing playlists Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 01 11:50:18 volumio volumio[1409]: info: Mar 01 11:50:18 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:18 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:18 volumio volumio[1409]: info: Mar 01 11:50:18 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:18 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:18 volumio volumio[1409]: info: Mar 01 11:50:18 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:18 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:18 volumio volumio[1409]: info: Mar 01 11:50:18 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:18 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:18 volumio volumio[1409]: info: Mar 01 11:50:18 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:18 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:18 volumio volumio[1409]: info: Mar 01 11:50:18 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:18 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:18 volumio volumio[1409]: info: ------------------------------ 6ms Mar 01 11:50:18 volumio volumio[1409]: info: sendMpdCommand status took 6 milliseconds Mar 01 11:50:18 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:50:18 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:18 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:50:18 volumio volumio[1409]: info: sendMpdCommand status took 5 milliseconds Mar 01 11:50:18 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:18 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:18 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:18 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":353684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:18 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:18 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:18 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:18 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":353684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:18 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:18 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:18 volumio volumio[1409]: info: ------------------------------ 56ms Mar 01 11:50:18 volumio volumio[1409]: info: ------------------------------ 55ms Mar 01 11:50:18 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 48 milliseconds Mar 01 11:50:18 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:18 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:18 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":353684,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:18 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:18 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:18 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:19 volumio volumio[1409]: info: ------------------------------ 73ms Mar 01 11:50:19 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Mar 01 11:50:19 volumio sudo[5802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Mar 01 11:50:19 volumio sudo[5807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 01 11:50:19 volumio sudo[5802]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:19 volumio sudo[5807]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:19 volumio sudo[5802]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:19 volumio sudo[5818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 01 11:50:19 volumio sudo[5807]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:19 volumio sudo[5818]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:19 volumio sudo[5824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Mar 01 11:50:19 volumio sudo[5835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 11:50:19 volumio sudo[5818]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:19 volumio sudo[5842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 11:50:19 volumio sudo[5824]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:19 volumio sudo[5835]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:19 volumio sudo[5835]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:19 volumio sudo[5824]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:19 volumio sudo[5842]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 11:50:19 volumio sudo[5842]: pam_unix(sudo:session): session closed for user root Mar 01 11:50:19 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 01 11:50:19 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 01 11:50:20 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 11:50:20 volumio volumio[1409]: info: Received Get System Info Mar 01 11:50:20 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 11:50:20 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 11:50:20 volumio volumio[1409]: info: Discovery: Getting this device information Mar 01 11:50:20 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:20 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 11:50:20 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 01 11:50:20 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 11:50:22 volumio volumio[1409]: info: Received Get System Info Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 11:50:22 volumio volumio[1409]: info: Discovery: Getting this device information Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 11:50:22 volumio volumio[1409]: info: Received Get System Info Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 11:50:22 volumio volumio[1409]: info: Discovery: Getting this device information Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:22 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 11:50:25 volumio volumio[1409]: info: Mar 01 11:50:25 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:25 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:25 volumio volumio[1409]: info: Mar 01 11:50:25 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:25 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:25 volumio volumio[1409]: info: Mar 01 11:50:25 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:25 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:25 volumio volumio[1409]: info: Mar 01 11:50:25 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:25 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:25 volumio volumio[1409]: info: Mar 01 11:50:25 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:25 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:25 volumio volumio[1409]: info: Mar 01 11:50:25 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:25 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:25 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:25 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:25 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:25 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:25 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:25 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:25 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:25 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:25 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:25 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":360285,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:25 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:25 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:25 volumio volumio[1409]: info: ------------------------------ 19ms Mar 01 11:50:25 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:25 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:25 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:25 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:25 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":360285,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:25 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:25 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:25 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:25 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:25 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":360285,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:25 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:25 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:25 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:25 volumio volumio[1409]: info: ------------------------------ 48ms Mar 01 11:50:25 volumio volumio[1409]: info: ------------------------------ 48ms Mar 01 11:50:27 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:27 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 01 11:50:30 volumio volumio[1409]: info: Mar 01 11:50:30 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:30 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:30 volumio volumio[1409]: info: Mar 01 11:50:30 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:30 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:30 volumio volumio[1409]: info: Mar 01 11:50:30 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:30 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:30 volumio volumio[1409]: info: Mar 01 11:50:30 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:30 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:30 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:30 volumio volumio[1409]: info: Mar 01 11:50:30 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:30 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:30 volumio volumio[1409]: info: Mar 01 11:50:30 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:30 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:30 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:30 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:30 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:30 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:50:30 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:30 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:30 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:30 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:30 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:30 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:30 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:30 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:30 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:30 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:30 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:30 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:30 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:30 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:30 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:30 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:30 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:30 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:30 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:30 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:30 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:30 volumio volumio[1409]: info: ------------------------------ 43ms Mar 01 11:50:30 volumio volumio[1409]: info: ------------------------------ 42ms Mar 01 11:50:30 volumio volumio[1409]: info: ------------------------------ 41ms Mar 01 11:50:31 volumio volumio[1409]: info: Mar 01 11:50:31 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:31 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:31 volumio volumio[1409]: info: Mar 01 11:50:31 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:31 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:31 volumio volumio[1409]: info: Mar 01 11:50:31 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:31 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:31 volumio volumio[1409]: info: Mar 01 11:50:31 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:31 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:31 volumio volumio[1409]: info: Mar 01 11:50:31 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:31 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:31 volumio volumio[1409]: info: Mar 01 11:50:31 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:31 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:31 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:50:31 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:31 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:31 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:50:31 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:50:31 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:31 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:31 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:31 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:31 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:31 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366483,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:31 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:31 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:31 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:31 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366483,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:31 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:31 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:31 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:31 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366483,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:31 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:31 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:31 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:31 volumio volumio[1409]: info: ------------------------------ 63ms Mar 01 11:50:31 volumio volumio[1409]: info: ------------------------------ 62ms Mar 01 11:50:31 volumio volumio[1409]: info: ------------------------------ 62ms Mar 01 11:50:35 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 11:50:35 volumio volumio[1409]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 01 11:50:35 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 01 11:50:35 volumio volumio[1409]: info: Received Get System Version Mar 01 11:50:35 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 11:50:35 volumio volumio[1409]: info: Received Get System Info Mar 01 11:50:35 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 11:50:35 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 11:50:35 volumio volumio[1409]: info: Discovery: Getting this device information Mar 01 11:50:35 volumio volumio[1409]: info: CoreCommandRouter::volumioGetState Mar 01 11:50:35 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 11:50:37 volumio volumio[1409]: info: Retrieving Cloud Streaming UI Mar 01 11:50:37 volumio volumio[1409]: info: Getting Tidal Cloud Configuration Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 11:50:37 volumio volumio[1409]: info: Getting Qobuz Cloud Configuration Mar 01 11:50:37 volumio volumio[1409]: info: Asking plugin for UI Config Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 11:50:37 volumio volumio[1409]: info: Getting Spotify Cloud Configuration Mar 01 11:50:37 volumio volumio[1409]: info: Asking plugin for UI Config Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 11:50:37 volumio volumio[1409]: info: Saving Spotify Acccount Mar 01 11:50:37 volumio volumio[1409]: info: Got Tidal Cloud Configuration Mar 01 11:50:37 volumio volumio[1409]: info: Got it Mar 01 11:50:37 volumio volumio[1409]: info: Got it Mar 01 11:50:37 volumio volumio[1409]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 11:50:37 volumio volumio[1409]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioGetBrowseSources Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioGetBrowseSources Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioGetBrowseSources Mar 01 11:50:37 volumio volumio[1409]: info: Mar 01 11:50:37 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:37 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:37 volumio volumio[1409]: info: Mar 01 11:50:37 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:37 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:37 volumio volumio[1409]: info: Mar 01 11:50:37 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:37 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:37 volumio volumio[1409]: info: Mar 01 11:50:37 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:37 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:37 volumio volumio[1409]: info: Mar 01 11:50:37 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:37 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:37 volumio volumio[1409]: info: Mar 01 11:50:37 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:37 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:37 volumio volumio[1409]: info: ------------------------------ 5ms Mar 01 11:50:37 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:37 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:37 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:37 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:37 volumio volumio[1409]: info: sendMpdCommand status took 2 milliseconds Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:37 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:37 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:37 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:37 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:37 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:37 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:37 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":372479,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:37 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:37 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:37 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:37 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:37 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":372479,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:37 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:37 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:37 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:37 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:37 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":372479,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:37 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:37 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:37 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:37 volumio volumio[1409]: info: ------------------------------ 52ms Mar 01 11:50:37 volumio volumio[1409]: info: ------------------------------ 51ms Mar 01 11:50:37 volumio volumio[1409]: info: ------------------------------ 50ms Mar 01 11:50:38 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 01 11:50:38 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 01 11:50:42 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 01 11:50:43 volumio volumio[1409]: info: Mar 01 11:50:43 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:43 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:43 volumio volumio[1409]: info: Mar 01 11:50:43 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:43 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:43 volumio volumio[1409]: info: Mar 01 11:50:43 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:43 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:43 volumio volumio[1409]: info: Mar 01 11:50:43 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:43 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:43 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:43 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:43 volumio volumio[1409]: info: ------------------------------ 2ms Mar 01 11:50:43 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:43 volumio volumio[1409]: info: Mar 01 11:50:43 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:43 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:43 volumio volumio[1409]: info: Mar 01 11:50:43 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:43 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:43 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:43 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 11:50:43 volumio volumio[1409]: info: ------------------------------ 1ms Mar 01 11:50:43 volumio volumio[1409]: info: sendMpdCommand status took 1 milliseconds Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:43 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:43 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":377880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:43 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:43 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:43 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:43 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":377880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:43 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:43 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:43 volumio volumio[1409]: info: ------------------------------ 46ms Mar 01 11:50:43 volumio volumio[1409]: info: ------------------------------ 48ms Mar 01 11:50:43 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 44 milliseconds Mar 01 11:50:43 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:43 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:43 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":377880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:43 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:43 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:43 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:43 volumio volumio[1409]: info: ------------------------------ 63ms Mar 01 11:50:46 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 01 11:50:49 volumio volumio[1409]: info: Mar 01 11:50:49 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:49 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:49 volumio volumio[1409]: info: Mar 01 11:50:49 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:49 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:49 volumio volumio[1409]: info: Mar 01 11:50:49 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:49 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:49 volumio volumio[1409]: info: Mar 01 11:50:49 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:49 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:49 volumio volumio[1409]: info: Mar 01 11:50:49 volumio volumio[1409]: ---------------------------- MPD announces system playlist update Mar 01 11:50:49 volumio volumio[1409]: info: Ignoring MPD Status Update Mar 01 11:50:49 volumio volumio[1409]: info: Mar 01 11:50:49 volumio volumio[1409]: ---------------------------- MPD announces state update: player Mar 01 11:50:49 volumio volumio[1409]: info: ControllerMpd::getState Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand status Mar 01 11:50:49 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:49 volumio volumio[1409]: info: sendMpdCommand status took 4 milliseconds Mar 01 11:50:49 volumio volumio[1409]: info: ------------------------------ 4ms Mar 01 11:50:49 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:49 volumio volumio[1409]: info: ------------------------------ 3ms Mar 01 11:50:49 volumio volumio[1409]: info: sendMpdCommand status took 3 milliseconds Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::parseState Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 11:50:49 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:49 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:49 volumio volumio[1409]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:49 volumio volumio[1409]: verbose: ControllerMpd::parseTrackInfo Mar 01 11:50:49 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:49 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:49 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":383786,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:49 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:49 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:49 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:49 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:49 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":383786,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:49 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:49 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:49 volumio volumio[1409]: info: ControllerMpd::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::servicePushState Mar 01 11:50:49 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:49 volumio volumio[1409]: verbose: STATE SERVICE {"status":"play","position":0,"seek":383786,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"13.mp3","artist":"Radio1Sport Ita","album":null,"uri":"http://icestreaming.rai.it/13.mp3","trackType":"mp3"} Mar 01 11:50:49 volumio volumio[1409]: verbose: CURRENT POSITION 0 Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::syncState stateService play Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::syncState currentStatus play Mar 01 11:50:49 volumio volumio[1409]: info: Received an update from plugin. extracting info from payload Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CorePlayQueue::getTrack 0 Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreStateMachine::pushState Mar 01 11:50:49 volumio volumio[1409]: info: CoreCommandRouter::volumioPushState Mar 01 11:50:49 volumio volumio[1409]: info: ------------------------------ 43ms Mar 01 11:50:49 volumio volumio[1409]: info: ------------------------------ 42ms Mar 01 11:50:49 volumio volumio[1409]: info: ------------------------------ 42ms Mar 01 11:50:50 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 01 11:50:50 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 01 11:50:50 volumio volumio[1409]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 01 11:50:50 volumio volumio[1409]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 11:50:50 volumio volumio[1409]: Error: getaddrinfo -3007 Mar 01 11:50:50 volumio volumio[1409]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Mar 01 11:50:50 volumio volumio[1409]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Mar 01 11:50:50 volumio volumio[1409]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Mar 01 11:50:50 volumio volumio[1409]: code: -3007, Mar 01 11:50:50 volumio volumio[1409]: errno: -3007, Mar 01 11:50:50 volumio volumio[1409]: syscall: 'getaddrinfo' Mar 01 11:50:50 volumio volumio[1409]: } Mar 01 11:50:50 volumio volumio[1409]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 11:50:51 volumio sudo[5980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 11:49 Mar 01 11:50:51 volumio sudo[5980]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:11:38 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="932fc3546f7cc8faa2b4d349036752dd"