-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Tue 2024-04-30 11:18:32 EDT. -- Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::volumioPause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::pause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::stPlaybackTimer Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::servicePause Apr 30 11:17:02 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::servicePause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 30 11:17:02 volumio volumio[811]: info: ControllerMpd::pause Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand pause Apr 30 11:17:02 volumio volumio[811]: info: Apr 30 11:17:02 volumio volumio[811]: ---------------------------- MPD announces state update: player Apr 30 11:17:02 volumio volumio[811]: info: sendMpdCommand pause took 6 milliseconds Apr 30 11:17:02 volumio volumio[811]: info: ControllerMpd::getState Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:17:02 volumio volumio[811]: info: Apr 30 11:17:02 volumio volumio[811]: ---------------------------- MPD announces state update: player Apr 30 11:17:02 volumio volumio[811]: info: ControllerMpd::getState Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:17:02 volumio volumio[811]: info: Apr 30 11:17:02 volumio volumio[811]: ---------------------------- MPD announces state update: player Apr 30 11:17:02 volumio volumio[811]: info: ControllerMpd::getState Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:17:02 volumio volumio[811]: info: sendMpdCommand status took 5 milliseconds Apr 30 11:17:02 volumio volumio[811]: info: sendMpdCommand status took 4 milliseconds Apr 30 11:17:02 volumio volumio[811]: info: sendMpdCommand status took 2 milliseconds Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::parseState Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::parseState Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::parseState Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:17:02 volumio volumio[811]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 30 11:17:02 volumio volumio[811]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 30 11:17:02 volumio volumio[811]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:17:02 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:17:02 volumio volumio[811]: info: ControllerMpd::pushState Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::servicePushState Apr 30 11:17:02 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:02 volumio volumio[811]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":80570,"duration":204,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"12 Kbps","isStreaming":false,"title":"Levitating","artist":"Dua Lipa","album":"Future Nostalgia","uri":"https://rr2---sn-8xgp1vo-cvne.googlevideo.com/videoplayback?expire=1714511738&ei=GgsxZvKBMNaVkucPzL2ByAM&ip=98.110.230.62&id=o-AHXvq7OrH0usimag6xw2S3y2g6f6WpF07P17_Tk22fGT&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Xe&mm=31%2C29&mn=sn-8xgp1vo-cvne%2Csn-8xgp1vo-xfge&ms=au%2Crdu&mv=m&mvi=2&pl=18&ctier=A&pfa=5&gcr=us&initcwndbps=773750&hightc=yes&siu=1&bui=AWRWj2RZ8tKpO-nSALMCQu3crGSeL_xlkq5SZIshilnR82IpZO7GR5tGJ31SHZi0lJ3AdEpW8Q&spc=UWF9f6B10DcUnyT035iTvI662mBqXanFFSctb0h0WEucVbyDoxYFAHLW4uL8&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=lJE5AxdjwlHbhCvml7wmy5wQ&gir=yes&clen=6562099&dur=203.807&lmt=1699868859709359&mt=1714489741&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=kw854r4ZJuoMrw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgSfJURH2mtwK28qsms_8QvntjceunEGDZIGM5GXW7BmQCIQClaDXymNoJhqKD7UbHuBGY7nMxc9Htecn7_jtGZrL3PQ%3D%3D&sig=AJfQdSswRgIhAMwtRamcGDnCQWxi8ftfWt97tkBHHbPbbAU2JL66niw4AiEA2tOkuPYR9VLf51f02ZMY7KAmd9mSGcjG5UshtynjD8o%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Apr 30 11:17:02 volumio volumio[811]: verbose: CURRENT POSITION 0 Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::syncState stateService pause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus pause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::stPlaybackTimer Apr 30 11:17:02 volumio volumio[811]: info: ControllerMpd::pushState Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::servicePushState Apr 30 11:17:02 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:02 volumio volumio[811]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":80570,"duration":204,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"12 Kbps","isStreaming":false,"title":"Levitating","artist":"Dua Lipa","album":"Future Nostalgia","uri":"https://rr2---sn-8xgp1vo-cvne.googlevideo.com/videoplayback?expire=1714511738&ei=GgsxZvKBMNaVkucPzL2ByAM&ip=98.110.230.62&id=o-AHXvq7OrH0usimag6xw2S3y2g6f6WpF07P17_Tk22fGT&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Xe&mm=31%2C29&mn=sn-8xgp1vo-cvne%2Csn-8xgp1vo-xfge&ms=au%2Crdu&mv=m&mvi=2&pl=18&ctier=A&pfa=5&gcr=us&initcwndbps=773750&hightc=yes&siu=1&bui=AWRWj2RZ8tKpO-nSALMCQu3crGSeL_xlkq5SZIshilnR82IpZO7GR5tGJ31SHZi0lJ3AdEpW8Q&spc=UWF9f6B10DcUnyT035iTvI662mBqXanFFSctb0h0WEucVbyDoxYFAHLW4uL8&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=lJE5AxdjwlHbhCvml7wmy5wQ&gir=yes&clen=6562099&dur=203.807&lmt=1699868859709359&mt=1714489741&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=kw854r4ZJuoMrw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgSfJURH2mtwK28qsms_8QvntjceunEGDZIGM5GXW7BmQCIQClaDXymNoJhqKD7UbHuBGY7nMxc9Htecn7_jtGZrL3PQ%3D%3D&sig=AJfQdSswRgIhAMwtRamcGDnCQWxi8ftfWt97tkBHHbPbbAU2JL66niw4AiEA2tOkuPYR9VLf51f02ZMY7KAmd9mSGcjG5UshtynjD8o%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Apr 30 11:17:02 volumio volumio[811]: verbose: CURRENT POSITION 0 Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::syncState stateService pause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus pause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::stPlaybackTimer Apr 30 11:17:02 volumio volumio[811]: info: ControllerMpd::pushState Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::servicePushState Apr 30 11:17:02 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:02 volumio volumio[811]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":80570,"duration":204,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"12 Kbps","isStreaming":false,"title":"Levitating","artist":"Dua Lipa","album":"Future Nostalgia","uri":"https://rr2---sn-8xgp1vo-cvne.googlevideo.com/videoplayback?expire=1714511738&ei=GgsxZvKBMNaVkucPzL2ByAM&ip=98.110.230.62&id=o-AHXvq7OrH0usimag6xw2S3y2g6f6WpF07P17_Tk22fGT&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Xe&mm=31%2C29&mn=sn-8xgp1vo-cvne%2Csn-8xgp1vo-xfge&ms=au%2Crdu&mv=m&mvi=2&pl=18&ctier=A&pfa=5&gcr=us&initcwndbps=773750&hightc=yes&siu=1&bui=AWRWj2RZ8tKpO-nSALMCQu3crGSeL_xlkq5SZIshilnR82IpZO7GR5tGJ31SHZi0lJ3AdEpW8Q&spc=UWF9f6B10DcUnyT035iTvI662mBqXanFFSctb0h0WEucVbyDoxYFAHLW4uL8&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=lJE5AxdjwlHbhCvml7wmy5wQ&gir=yes&clen=6562099&dur=203.807&lmt=1699868859709359&mt=1714489741&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=kw854r4ZJuoMrw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgSfJURH2mtwK28qsms_8QvntjceunEGDZIGM5GXW7BmQCIQClaDXymNoJhqKD7UbHuBGY7nMxc9Htecn7_jtGZrL3PQ%3D%3D&sig=AJfQdSswRgIhAMwtRamcGDnCQWxi8ftfWt97tkBHHbPbbAU2JL66niw4AiEA2tOkuPYR9VLf51f02ZMY7KAmd9mSGcjG5UshtynjD8o%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Apr 30 11:17:02 volumio volumio[811]: verbose: CURRENT POSITION 0 Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::syncState stateService pause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus pause Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:02 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:02 volumio volumio[811]: info: CoreStateMachine::stPlaybackTimer Apr 30 11:17:02 volumio volumio[811]: info: ------------------------------ 34ms Apr 30 11:17:02 volumio volumio[811]: info: ------------------------------ 31ms Apr 30 11:17:02 volumio volumio[811]: info: ------------------------------ 30ms Apr 30 11:17:02 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:02 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:02 volumio volumio[811]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 30 11:17:02 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:02 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:02 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:02 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:20 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:20 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:21 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:21 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:21 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:21 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:21 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:21 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:21 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:21 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:22 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:22 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:22 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:23 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:23 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:23 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:23 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:24 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:24 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:24 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:24 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:25 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:25 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:26 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:26 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:27 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPlay Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::play index undefined Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 11:17:27 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::startPlaybackTimer Apr 30 11:17:27 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 30 11:17:27 volumio volumio[811]: info: ControllerMpd::resume Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand play Apr 30 11:17:27 volumio volumio[811]: info: Apr 30 11:17:27 volumio volumio[811]: ---------------------------- MPD announces state update: player Apr 30 11:17:27 volumio volumio[811]: info: sendMpdCommand play took 18 milliseconds Apr 30 11:17:27 volumio volumio[811]: info: ControllerMpd::getState Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:17:27 volumio volumio[811]: info: sendMpdCommand status took 7 milliseconds Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::parseState Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:17:27 volumio volumio[811]: info: Apr 30 11:17:27 volumio volumio[811]: ---------------------------- MPD announces state update: player Apr 30 11:17:27 volumio volumio[811]: info: ControllerMpd::getState Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:17:27 volumio volumio[811]: info: Apr 30 11:17:27 volumio volumio[811]: ---------------------------- MPD announces state update: player Apr 30 11:17:27 volumio volumio[811]: info: ControllerMpd::getState Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:27 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:27 volumio volumio[811]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 30 11:17:27 volumio volumio[811]: info: sendMpdCommand status took 12 milliseconds Apr 30 11:17:27 volumio volumio[811]: info: sendMpdCommand status took 11 milliseconds Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::parseState Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::parseState Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:17:27 volumio volumio[811]: info: ControllerMpd::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::servicePushState Apr 30 11:17:27 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:27 volumio volumio[811]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81564,"duration":204,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"12 Kbps","isStreaming":false,"title":"Levitating","artist":"Dua Lipa","album":"Future Nostalgia","uri":"https://rr2---sn-8xgp1vo-cvne.googlevideo.com/videoplayback?expire=1714511738&ei=GgsxZvKBMNaVkucPzL2ByAM&ip=98.110.230.62&id=o-AHXvq7OrH0usimag6xw2S3y2g6f6WpF07P17_Tk22fGT&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Xe&mm=31%2C29&mn=sn-8xgp1vo-cvne%2Csn-8xgp1vo-xfge&ms=au%2Crdu&mv=m&mvi=2&pl=18&ctier=A&pfa=5&gcr=us&initcwndbps=773750&hightc=yes&siu=1&bui=AWRWj2RZ8tKpO-nSALMCQu3crGSeL_xlkq5SZIshilnR82IpZO7GR5tGJ31SHZi0lJ3AdEpW8Q&spc=UWF9f6B10DcUnyT035iTvI662mBqXanFFSctb0h0WEucVbyDoxYFAHLW4uL8&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=lJE5AxdjwlHbhCvml7wmy5wQ&gir=yes&clen=6562099&dur=203.807&lmt=1699868859709359&mt=1714489741&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=kw854r4ZJuoMrw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgSfJURH2mtwK28qsms_8QvntjceunEGDZIGM5GXW7BmQCIQClaDXymNoJhqKD7UbHuBGY7nMxc9Htecn7_jtGZrL3PQ%3D%3D&sig=AJfQdSswRgIhAMwtRamcGDnCQWxi8ftfWt97tkBHHbPbbAU2JL66niw4AiEA2tOkuPYR9VLf51f02ZMY7KAmd9mSGcjG5UshtynjD8o%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Apr 30 11:17:27 volumio volumio[811]: verbose: CURRENT POSITION 0 Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::syncState stateService play Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus pause Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: ------------------------------ 33ms Apr 30 11:17:27 volumio volumio[811]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 30 11:17:27 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:17:27 volumio volumio[811]: info: ControllerMpd::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::servicePushState Apr 30 11:17:27 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:27 volumio volumio[811]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81564,"duration":204,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"12 Kbps","isStreaming":false,"title":"Levitating","artist":"Dua Lipa","album":"Future Nostalgia","uri":"https://rr2---sn-8xgp1vo-cvne.googlevideo.com/videoplayback?expire=1714511738&ei=GgsxZvKBMNaVkucPzL2ByAM&ip=98.110.230.62&id=o-AHXvq7OrH0usimag6xw2S3y2g6f6WpF07P17_Tk22fGT&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Xe&mm=31%2C29&mn=sn-8xgp1vo-cvne%2Csn-8xgp1vo-xfge&ms=au%2Crdu&mv=m&mvi=2&pl=18&ctier=A&pfa=5&gcr=us&initcwndbps=773750&hightc=yes&siu=1&bui=AWRWj2RZ8tKpO-nSALMCQu3crGSeL_xlkq5SZIshilnR82IpZO7GR5tGJ31SHZi0lJ3AdEpW8Q&spc=UWF9f6B10DcUnyT035iTvI662mBqXanFFSctb0h0WEucVbyDoxYFAHLW4uL8&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=lJE5AxdjwlHbhCvml7wmy5wQ&gir=yes&clen=6562099&dur=203.807&lmt=1699868859709359&mt=1714489741&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=kw854r4ZJuoMrw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgSfJURH2mtwK28qsms_8QvntjceunEGDZIGM5GXW7BmQCIQClaDXymNoJhqKD7UbHuBGY7nMxc9Htecn7_jtGZrL3PQ%3D%3D&sig=AJfQdSswRgIhAMwtRamcGDnCQWxi8ftfWt97tkBHHbPbbAU2JL66niw4AiEA2tOkuPYR9VLf51f02ZMY7KAmd9mSGcjG5UshtynjD8o%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Apr 30 11:17:27 volumio volumio[811]: verbose: CURRENT POSITION 0 Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::syncState stateService play Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus play Apr 30 11:17:27 volumio volumio[811]: info: Received an update from plugin. extracting info from payload Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: ControllerMpd::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::servicePushState Apr 30 11:17:27 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Apr 30 11:17:27 volumio volumio[811]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81564,"duration":204,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"12 Kbps","isStreaming":false,"title":"Levitating","artist":"Dua Lipa","album":"Future Nostalgia","uri":"https://rr2---sn-8xgp1vo-cvne.googlevideo.com/videoplayback?expire=1714511738&ei=GgsxZvKBMNaVkucPzL2ByAM&ip=98.110.230.62&id=o-AHXvq7OrH0usimag6xw2S3y2g6f6WpF07P17_Tk22fGT&itag=141&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Xe&mm=31%2C29&mn=sn-8xgp1vo-cvne%2Csn-8xgp1vo-xfge&ms=au%2Crdu&mv=m&mvi=2&pl=18&ctier=A&pfa=5&gcr=us&initcwndbps=773750&hightc=yes&siu=1&bui=AWRWj2RZ8tKpO-nSALMCQu3crGSeL_xlkq5SZIshilnR82IpZO7GR5tGJ31SHZi0lJ3AdEpW8Q&spc=UWF9f6B10DcUnyT035iTvI662mBqXanFFSctb0h0WEucVbyDoxYFAHLW4uL8&vprv=1&svpuc=1&mime=audio%2Fmp4&ns=lJE5AxdjwlHbhCvml7wmy5wQ&gir=yes&clen=6562099&dur=203.807&lmt=1699868859709359&mt=1714489741&fvip=1&keepalive=yes&c=WEB_REMIX&sefc=1&txp=4532434&n=kw854r4ZJuoMrw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cctier%2Cpfa%2Cgcr%2Chightc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIgSfJURH2mtwK28qsms_8QvntjceunEGDZIGM5GXW7BmQCIQClaDXymNoJhqKD7UbHuBGY7nMxc9Htecn7_jtGZrL3PQ%3D%3D&sig=AJfQdSswRgIhAMwtRamcGDnCQWxi8ftfWt97tkBHHbPbbAU2JL66niw4AiEA2tOkuPYR9VLf51f02ZMY7KAmd9mSGcjG5UshtynjD8o%3D&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"} Apr 30 11:17:27 volumio volumio[811]: verbose: CURRENT POSITION 0 Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::syncState stateService play Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus play Apr 30 11:17:27 volumio volumio[811]: info: Received an update from plugin. extracting info from payload Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:27 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:27 volumio volumio[811]: info: ------------------------------ 49ms Apr 30 11:17:27 volumio volumio[811]: info: ------------------------------ 49ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:28 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:28 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:28 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:28 volumio volumio[811]: error: error Apr 30 11:17:28 volumio volumio[811]: error: error Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:28 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: error: error Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:29 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:29 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:29 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:30 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:30 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:30 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:30 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:31 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:31 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:31 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:31 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:31 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:31 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:31 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:31 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:31 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:32 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:32 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:32 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:32 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:32 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:32 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:32 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:32 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: VolumeController::SetAlsaVolumemute Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:32 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:32 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: pause PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] InitTimeout - Amp off in: 300000 ms Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:32 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:35 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:35 volumio volumio[811]: info: VolumeController::SetAlsaVolume- Apr 30 11:17:35 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:35 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:35 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:35 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:35 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:35 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:35 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:35 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:35 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:35 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:35 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:35 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:35 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:35 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:35 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:35 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:35 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:35 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:35 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:35 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:40 volumio volumio[811]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. Apr 30 11:17:44 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:44 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:44 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:44 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:44 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:44 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:44 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:44 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:44 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:44 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:45 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:45 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:45 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:45 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:45 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:45 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:45 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:45 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:45 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:45 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:45 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:45 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:45 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:46 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:46 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:46 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:46 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:46 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:46 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:46 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:46 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:46 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:46 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:46 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:46 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:46 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:46 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:46 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:46 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:47 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:47 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:47 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:47 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:47 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:47 volumio volumio[811]: info: VolumeController::SetAlsaVolume+ Apr 30 11:17:47 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:47 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:17:47 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:47 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:17:47 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:17:47 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:47 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:47 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:17:59 volumio dhcpcd[746]: wlan0: carrier lost Apr 30 11:17:59 volumio wpa_supplicant[736]: wlan0: Associated with 38:86:f7:fe:ba:5b Apr 30 11:17:59 volumio wpa_supplicant[736]: wlan0: CTRL-EVENT-CONNECTED - Connection to 38:86:f7:fe:ba:5b completed [id=0 id_str=] Apr 30 11:17:59 volumio wpa_supplicant[736]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 30 11:17:59 volumio avahi-daemon[481]: Withdrawing address record for 192.168.86.103 on wlan0. Apr 30 11:17:59 volumio avahi-daemon[481]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.86.103. Apr 30 11:17:59 volumio avahi-daemon[481]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 30 11:17:59 volumio dhcpcd[746]: wlan0: deleting route to 192.168.86.0/24 Apr 30 11:17:59 volumio dhcpcd[746]: wlan0: deleting default route via 192.168.86.1 Apr 30 11:17:59 volumio volumio[811]: info: Discovery: A device disappeared from network Apr 30 11:17:59 volumio volumio[811]: info: Discovery: Device volumio disappeared from network Apr 30 11:17:59 volumio dhcpcd[746]: wlan0: carrier acquired Apr 30 11:17:59 volumio dhcpcd[746]: wlan0: IAID eb:12:4c:d9 Apr 30 11:18:00 volumio dhcpcd[746]: wlan0: rebinding lease of 192.168.86.103 Apr 30 11:18:00 volumio dhcpcd[746]: wlan0: probing address 192.168.86.103/24 Apr 30 11:18:00 volumio dhcpcd[746]: wlan0: soliciting an IPv6 router Apr 30 11:18:00 volumio ntpd[642]: Deleting interface #3 wlan0, 192.168.86.103#123, interface stats: received=60, sent=70, dropped=0, active_time=226 secs Apr 30 11:18:00 volumio ntpd[642]: 129.250.35.251 local addr 192.168.86.103 -> Apr 30 11:18:00 volumio ntpd[642]: 137.184.81.69 local addr 192.168.86.103 -> Apr 30 11:18:00 volumio ntpd[642]: 147.182.158.78 local addr 192.168.86.103 -> Apr 30 11:18:00 volumio ntpd[642]: 209.51.161.238 local addr 192.168.86.103 -> Apr 30 11:18:00 volumio ntpd[642]: 137.190.2.4 local addr 192.168.86.103 -> Apr 30 11:18:00 volumio ntpd[642]: 152.70.159.102 local addr 192.168.86.103 -> Apr 30 11:18:03 volumio nmbd[590]: [2024/04/30 11:18:03.188607, 0] ../source3/nmbd/nmbd.c:361(reload_interfaces) Apr 30 11:18:03 volumio nmbd[590]: reload_interfaces: No subnets to listen to. Waiting.. Apr 30 11:18:05 volumio volumio[811]: info: VolumeController::SetAlsaVolume44 Apr 30 11:18:05 volumio volumio[811]: info: CoreStateMachine::pushState Apr 30 11:18:05 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:18:05 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Apr 30 11:18:05 volumio volumio[811]: info: [ASDebug] CurState: play PrevState: play Apr 30 11:18:06 volumio dhcpcd[746]: wlan0: leased 192.168.86.103 for 86400 seconds Apr 30 11:18:06 volumio avahi-daemon[481]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.86.103. Apr 30 11:18:06 volumio avahi-daemon[481]: New relevant interface wlan0.IPv4 for mDNS. Apr 30 11:18:06 volumio dhcpcd[746]: wlan0: adding route to 192.168.86.0/24 Apr 30 11:18:06 volumio avahi-daemon[481]: Registering new address record for 192.168.86.103 on wlan0.IPv4. Apr 30 11:18:06 volumio dhcpcd[746]: wlan0: adding default route via 192.168.86.1 Apr 30 11:18:07 volumio volumio[811]: info: Discovery: adding d2ae8897-d992-4b2f-b534-3161ca8981c9 Apr 30 11:18:07 volumio volumio[811]: info: Discovery: Found device Volumio Apr 30 11:18:07 volumio volumio[811]: info: CoreCommandRouter::volumioGetState Apr 30 11:18:07 volumio ntpd[642]: Listen normally on 4 wlan0 192.168.86.103:123 Apr 30 11:18:07 volumio ntpd[642]: new interface(s) found: waking up resolver Apr 30 11:18:10 volumio volumio[811]: info: [ASDebug] Port: 21 Apr 30 11:18:10 volumio volumio[811]: info: [ASDebug] Inverted: true Apr 30 11:18:10 volumio volumio[811]: info: [ASDebug] Delay: 300000 Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:18 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio volumio[811]: error: error Apr 30 11:18:19 volumio ntpd[642]: Soliciting pool server 143.215.130.72 Apr 30 11:18:20 volumio ntpd[642]: Soliciting pool server 12.167.151.1 Apr 30 11:18:22 volumio ntpd[642]: Soliciting pool server 99.119.214.210 Apr 30 11:18:23 volumio ntpd[642]: Soliciting pool server 2620:138:5000:0:5054:ff:fe89:6673 Apr 30 11:18:27 volumio ntpd[642]: Soliciting pool server 64.79.100.196 Apr 30 11:18:27 volumio ntpd[642]: Soliciting pool server 74.6.168.72 Apr 30 11:18:28 volumio ntpd[642]: Soliciting pool server 209.38.132.42 Apr 30 11:18:29 volumio ntpd[642]: Soliciting pool server 162.159.200.123 Apr 30 11:18:29 volumio ntpd[642]: Soliciting pool server 104.236.167.15 Apr 30 11:18:29 volumio ntpd[642]: Soliciting pool server 66.118.228.14 Apr 30 11:18:31 volumio volumio[811]: info: Starting Uninstall of plugin system_controller - ampswitch Apr 30 11:18:31 volumio volumio[811]: info: Uninstalling plugin ampswitch Apr 30 11:18:31 volumio volumio[811]: info: [ASDebug] Port: 21 Apr 30 11:18:31 volumio volumio[811]: info: [ASDebug] Inverted: true Apr 30 11:18:31 volumio volumio[811]: info: [ASDebug] Delay: 300000 Apr 30 11:18:31 volumio volumio[811]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 11:18:31 volumio volumio[811]: Error: EBADF: bad file descriptor, close Apr 30 11:18:31 volumio volumio[811]: at Object.closeSync (fs.js:439:3) Apr 30 11:18:31 volumio volumio[811]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Apr 30 11:18:31 volumio volumio[811]: at Object.closeSync (/data/plugins/system_hardware/gpio-buttons/node_modules/graceful-fs/graceful-fs.js:51:27) Apr 30 11:18:31 volumio volumio[811]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Apr 30 11:18:31 volumio volumio[811]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:234:19) Apr 30 11:18:31 volumio volumio[811]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:84:10) Apr 30 11:18:31 volumio volumio[811]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 30 11:18:31 volumio volumio[811]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Apr 30 11:18:31 volumio volumio[811]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1459:22) Apr 30 11:18:31 volumio volumio[811]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1218:45) Apr 30 11:18:31 volumio volumio[811]: at Socket.emit (events.js:315:20) Apr 30 11:18:31 volumio volumio[811]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 30 11:18:31 volumio volumio[811]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 30 11:18:31 volumio volumio[811]: errno: -9, Apr 30 11:18:31 volumio volumio[811]: syscall: 'close', Apr 30 11:18:31 volumio volumio[811]: code: 'EBADF' Apr 30 11:18:31 volumio volumio[811]: } Apr 30 11:18:31 volumio volumio[811]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 11:18:32 volumio sudo[2726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-30 11:17 Apr 30 11:18:32 volumio sudo[2726]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"