-- Logs begin at Tue 2024-10-22 23:30:43 +05, end at Wed 2024-10-23 15:32:57 +05. -- Oct 23 15:31:24 volumio ntpd[895]: receive: Unexpected origin timestamp 0xeac26e27.15c8b8a7 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xeac34efc.f2a8dad8 Oct 23 15:31:24 volumio ntpd[895]: receive: Unexpected origin timestamp 0xeac26e27.15d121d3 does not match aorg 0000000000.00000000 from server@194.190.168.1 xmt 0xeac34efc.f2c0615f Oct 23 15:31:24 volumio ntpd[895]: receive: Unexpected origin timestamp 0xeac26e27.15cf68fd does not match aorg 0000000000.00000000 from server@178.20.41.3 xmt 0xeac34efc.f45486b6 Oct 23 15:31:25 volumio ntpd[895]: receive: Unexpected origin timestamp 0xeac26e27.15d4660c does not match aorg 0000000000.00000000 from server@185.251.115.30 xmt 0xeac34efc.f5db4f51 Oct 23 15:31:25 volumio systemd[1]: Starting Daily apt download activities... Oct 23 15:31:25 volumio systemd[1]: Starting Daily man-db regeneration... Oct 23 15:31:25 volumio volumio[1167]: info: Discovery: A device disappeared from network Oct 23 15:31:25 volumio volumio[1167]: info: Discovery: Device volumio disappeared from network Oct 23 15:31:25 volumio volumio[1167]: info: Discovery: A device disappeared from network Oct 23 15:31:25 volumio volumio[1167]: info: CoreStateMachine::ClearQueue Oct 23 15:31:25 volumio volumio[1167]: info: CoreStateMachine::stop Oct 23 15:31:25 volumio volumio[1167]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 15:31:25 volumio volumio[1167]: info: CorePlayQueue::clearPlayQueue Oct 23 15:31:25 volumio volumio[1167]: info: CorePlayQueue::saveQueue Oct 23 15:31:25 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:25 volumio volumio[1167]: info: CoreCommandRouter::volumioPushQueue Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: error: updateQueue error: null Oct 23 15:31:25 volumio volumio[1167]: error: updateQueue error: null Oct 23 15:31:25 volumio volumio[1167]: error: updateQueue error: null Oct 23 15:31:25 volumio volumio[1167]: error: updateQueue error: null Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 14ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 10ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 9ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 8ms Oct 23 15:31:25 volumio volumio[1167]: info: Starting UPNP Playback Oct 23 15:31:25 volumio volumio[1167]: info: Preparing playback through UPNP Oct 23 15:31:25 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:25 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Oct 23 15:31:25 volumio volumio[1167]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 15:31:25 volumio systemd[1]: man-db.service: Succeeded. Oct 23 15:31:25 volumio systemd[1]: Started Daily man-db regeneration. Oct 23 15:31:25 volumio volumio[1167]: info: Discovery: adding 9d690b12-0aa5-4d76-a9cd-2b35de434662 Oct 23 15:31:25 volumio volumio[1167]: info: Discovery: Found device Volumio Oct 23 15:31:25 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:25 volumio volumio[1167]: info: Discovery: this is already registered, 9d690b12-0aa5-4d76-a9cd-2b35de434662 Oct 23 15:31:25 volumio volumio[1167]: info: Discovery: Found device Volumio Oct 23 15:31:25 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 11ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 9ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 8ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 7ms Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 9ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 6ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 5ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 5ms Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 10ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 7ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 5ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 4ms Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 7ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 6ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 5ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 3ms Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 8ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 6ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 5ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 3ms Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:25 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 7ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 6ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 4ms Oct 23 15:31:25 volumio volumio[1167]: info: ------------------------------ 3ms Oct 23 15:31:25 volumio volumio[1167]: info: Starting UPNP Playback Oct 23 15:31:25 volumio volumio[1167]: info: Preparing playback through UPNP Oct 23 15:31:25 volumio volumio[1167]: info: Consume mode Oct 23 15:31:25 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:25 volumio volumio[1167]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:25 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:25 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:25 volumio volumio[1167]: info: Oct 23 15:31:25 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:25 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:25 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 23 15:31:26 volumio volumio[1167]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 525 milliseconds Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 531 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 530 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 527 milliseconds Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces state update: player Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::getState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand status Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 37 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 37ms Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 34 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 36ms Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 32 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 31 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 31 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 17ms Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 16 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 15ms Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 12 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 12ms Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand status took 10 milliseconds Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseState Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus stop Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Oct 23 15:31:26 volumio volumio[1167]: info: Received an update from plugin. extracting info from payload Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Oct 23 15:31:26 volumio volumio[1167]: info: Received an update from plugin. extracting info from payload Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Oct 23 15:31:26 volumio volumio[1167]: info: Received an update from plugin. extracting info from payload Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 634ms Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 765ms Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 766ms Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 766ms Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: Oct 23 15:31:26 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:26 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 236 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 235 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 235 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: sendMpdCommand playlistinfo took 234 milliseconds Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 24ms Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 21ms Oct 23 15:31:26 volumio volumio[1167]: info: ------------------------------ 18ms Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: verbose: ControllerMpd::parseTrackInfo Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Oct 23 15:31:26 volumio volumio[1167]: info: Received an update from plugin. extracting info from payload Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Oct 23 15:31:26 volumio volumio[1167]: info: Received an update from plugin. extracting info from payload Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Oct 23 15:31:26 volumio volumio[1167]: info: Received an update from plugin. extracting info from payload Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: ControllerMpd::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::servicePushState Oct 23 15:31:26 volumio volumio[1167]: verbose: In UPNP mode Oct 23 15:31:26 volumio volumio[1167]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":100,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Poison","artist":"Omnimar","album":"Zaycev.Net","uri":"http://192.168.0.24:40199/msp/MEDIA/584/_data/584.mp3?mt=YXVkaW8vbXBlZw","trackType":""} Oct 23 15:31:26 volumio volumio[1167]: verbose: CURRENT POSITION 0 Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState stateService play Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::syncState currentStatus play Oct 23 15:31:26 volumio volumio[1167]: info: Received an update from plugin. extracting info from payload Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:26 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:27 volumio volumio[1167]: info: ------------------------------ 576ms Oct 23 15:31:27 volumio volumio[1167]: info: ------------------------------ 556ms Oct 23 15:31:27 volumio volumio[1167]: info: ------------------------------ 555ms Oct 23 15:31:27 volumio volumio[1167]: info: ------------------------------ 553ms Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:27 volumio volumio[1167]: info: Oct 23 15:31:27 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:27 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:27 volumio volumio[1167]: info: Oct 23 15:31:27 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:27 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:27 volumio volumio[1167]: info: Oct 23 15:31:27 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:27 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: ------------------------------ 454ms Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:27 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:27 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:27 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:27 volumio kernel: sched: RT throttling activated Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 866ms Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 865ms Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 862ms Oct 23 15:31:28 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 36ms Oct 23 15:31:28 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:28 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:28 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 956ms Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 954ms Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 952ms Oct 23 15:31:28 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 28ms Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 24ms Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 21ms Oct 23 15:31:28 volumio volumio[1167]: info: ------------------------------ 19ms Oct 23 15:31:28 volumio volumio[1167]: info: Oct 23 15:31:28 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:28 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: Oct 23 15:31:29 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:29 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: Oct 23 15:31:29 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:29 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: Oct 23 15:31:29 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:29 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 24ms Oct 23 15:31:29 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:29 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:29 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:29 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:29 volumio volumio[1167]: info: Oct 23 15:31:29 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:29 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 953ms Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 951ms Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 949ms Oct 23 15:31:29 volumio volumio[1167]: info: Oct 23 15:31:29 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:29 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: Oct 23 15:31:29 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:29 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: Oct 23 15:31:29 volumio volumio[1167]: ---------------------------- MPD announces system playlist update Oct 23 15:31:29 volumio volumio[1167]: info: Ignoring MPD Status Update Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 20ms Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 18ms Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 17ms Oct 23 15:31:29 volumio volumio[1167]: info: ------------------------------ 15ms Oct 23 15:31:30 volumio systemd[1]: apt-daily.service: Succeeded. Oct 23 15:31:30 volumio systemd[1]: Started Daily apt download activities. Oct 23 15:31:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:30 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:30 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:30 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:31 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:31 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:31 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:32 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:32 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:32 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:32 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:32 volumio volumio[1167]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 23 15:31:32 volumio volumio[1167]: info: Completed starting MyVolumio Plugin Oct 23 15:31:32 volumio volumio[1167]: info: BOOT COMPLETED Oct 23 15:31:32 volumio volumio[1167]: [Metrics] CommandRouter: 65s 918.99ms Oct 23 15:31:32 volumio volumio[1167]: info: CoreCommandRouter::volumiosetStartupVolume Oct 23 15:31:32 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:32 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:31:32 volumio volumio[1167]: info: CoreCommandRouter::Close All Modals sent Oct 23 15:31:32 volumio volumio[1167]: info: CoreCommandRouter::Close All Modals sent Oct 23 15:31:33 volumio volumio[1167]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Oct 23 15:31:33 volumio volumio[1167]: aplay: main:828: audio open error: Device or resource busy Oct 23 15:31:33 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:33 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:33 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:33 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:33 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 23 15:31:33 volumio systemd[1]: Started Daily apt upgrade and clean activities. Oct 23 15:31:33 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 23 15:31:33 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:31:34 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 23 15:31:34 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:34 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:34 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:34 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:35 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:35 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:35 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:35 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:35 volumio kernel: hwmon hwmon1: Voltage normalised Oct 23 15:31:36 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:36 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:36 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:36 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:37 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:37 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:37 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:37 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:37 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:37 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:37 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:38 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:38 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:38 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:38 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:39 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:39 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:39 volumio volumio[1167]: info: Retrieving Cloud Streaming UI Oct 23 15:31:39 volumio volumio[1167]: info: Getting Tidal Cloud Configuration Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:39 volumio volumio[1167]: info: Getting Qobuz Cloud Configuration Oct 23 15:31:39 volumio volumio[1167]: info: Asking plugin for UI Config Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:39 volumio volumio[1167]: info: Getting Spotify Cloud Configuration Oct 23 15:31:39 volumio volumio[1167]: info: Asking plugin for UI Config Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:39 volumio volumio[1167]: info: Saving Spotify Acccount Oct 23 15:31:39 volumio volumio[1167]: info: Got Tidal Cloud Configuration Oct 23 15:31:39 volumio volumio[1167]: info: Got it Oct 23 15:31:39 volumio volumio[1167]: info: Got it Oct 23 15:31:39 volumio volumio[1167]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:39 volumio volumio[1167]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 15:31:39 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 23 15:31:40 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:40 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:40 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:40 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:41 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:41 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:41 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:41 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:42 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:42 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 23 15:31:42 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:31:43 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:43 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:43 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:43 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:44 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:44 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:44 volumio volumio[1167]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 23 15:31:44 volumio volumio[1167]: info: Preparing to save Alsa Options, stopping services first Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::volumioPause Oct 23 15:31:44 volumio volumio[1167]: info: CoreStateMachine::pause Oct 23 15:31:44 volumio volumio[1167]: info: CoreStateMachine::stPlaybackTimer Oct 23 15:31:44 volumio volumio[1167]: info: CoreStateMachine::servicePause Oct 23 15:31:44 volumio volumio[1167]: info: CorePlayQueue::getTrack 0 Oct 23 15:31:44 volumio volumio[1167]: info: Error: no service or no trackblock to pause Oct 23 15:31:44 volumio volumio[1167]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"NAD USB Audio 2.0"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:31:44 volumio volumio[1167]: info: Setting mixer Analogue 18 for card NAD USB Audio 2.0 Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 23 15:31:44 volumio volumio[1167]: info: Updating Volume Controller Parameters: Device: 5 Name: NAD USB Audio 2.0 Mixer: Analogue 18 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 23 15:31:44 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 23 15:31:44 volumio volumio[1167]: info: Disabling external Volume Control Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:31:45 volumio volumio[1167]: info: Preparing to generate the ALSA configuration file Oct 23 15:31:45 volumio volumio[1167]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Oct 23 15:31:45 volumio volumio[1167]: info: Reading ALSA contributions from plugins. Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:45 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:45 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:45 volumio volumio[1167]: info: VolumeController:: Volume=100 Mute =false Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:45 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:45 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:45 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:45 volumio volumio[1167]: info: Asound.conf file unchanged, so no further update is needed Oct 23 15:31:45 volumio volumio[1167]: info: Output device has changed, restarting MPD Oct 23 15:31:45 volumio sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 23 15:31:45 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:31:45 volumio volumio[1167]: info: Output device has changed, restarting Shairport Sync Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:31:45 volumio sudo[1854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 23 15:31:45 volumio sudo[1854]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:31:45 volumio systemd[1]: musicservicesshield.service: Succeeded. Oct 23 15:31:45 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Oct 23 15:31:45 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Oct 23 15:31:45 volumio systemd[1]: Stopping Music Player Daemon... Oct 23 15:31:45 volumio volumio[1167]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 23 15:31:45 volumio volumio[1167]: info: MPD Permissions set Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 23 15:31:45 volumio volumio[1167]: info: Starting Shairport Sync Oct 23 15:31:45 volumio sudo[1864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 23 15:31:45 volumio sudo[1864]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:31:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 23 15:31:45 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 23 15:31:45 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:31:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 23 15:31:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 23 15:31:46 volumio sudo[1864]: pam_unix(sudo:session): session closed for user root Oct 23 15:31:46 volumio volumio[1167]: info: Shairport-Sync Started Oct 23 15:31:46 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:46 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:46 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:46 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:47 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:47 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:47 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:47 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:48 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:48 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:48 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:48 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 23 15:31:49 volumio volumio[1167]: info: CoreStateMachine::getcurrentVolume Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioRetrievevolume Oct 23 15:31:49 volumio volumio[1167]: info: VolumeController:: Volume=100 Mute =false Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:49 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:49 volumio volumio[1167]: info: CoreStateMachine::updateTrackBlock Oct 23 15:31:49 volumio volumio[1167]: info: CorePlayQueue::getTrackBlock Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioRetrievevolume Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:49 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:49 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:49 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:49 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:49 volumio volumio[1167]: info: VolumeController:: Volume=100 Mute =false Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:49 volumio volumio[1167]: info: CoreStateMachine::pushState Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioPushState Oct 23 15:31:49 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:49 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:49 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:50 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:50 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:50 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:50 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:50 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:31:50 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:31:50 volumio volumio[1167]: info: Discovery: Getting this device information Oct 23 15:31:50 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:50 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:31:51 volumio kernel: hwmon hwmon1: Voltage normalised Oct 23 15:31:51 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:51 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:51 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:51 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:52 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:52 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:52 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:52 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:53 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:53 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:53 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:53 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:54 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:54 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:54 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:54 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:55 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:55 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:55 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:55 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:56 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:56 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:56 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:56 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:57 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:57 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:57 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:57 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:58 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:58 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:58 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:58 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:31:58 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:31:59 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:31:59 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:31:59 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:31:59 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:00 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:00 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:00 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:00 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:01 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:01 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:01 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:01 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:01 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 23 15:32:01 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 23 15:32:02 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:02 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:02 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:02 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:03 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:03 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:03 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:03 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:03 volumio kernel: hwmon hwmon1: Voltage normalised Oct 23 15:32:04 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:04 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:04 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:04 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:05 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:05 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:05 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:05 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:06 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:06 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:06 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:06 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:07 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:07 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:07 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:07 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:08 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:08 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:08 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:08 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:09 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:09 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:09 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:09 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:10 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:10 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:10 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:10 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:11 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:11 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:11 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:11 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:12 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:12 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:12 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:12 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:13 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:13 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:13 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:13 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:14 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:14 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:14 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:14 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:15 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:15 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:15 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:15 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:16 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:16 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:16 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:16 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:17 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:17 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:17 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:17 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:18 volumio volumio[1167]: info: Enabling plugin minidlna Oct 23 15:32:18 volumio volumio[1167]: info: Loading plugin "minidlna"... Oct 23 15:32:21 volumio volumio[1167]: info: Applying required configuration parameters for plugin minidlna Oct 23 15:32:24 volumio volumio[1167]: info: PLUGIN START: minidlna Oct 23 15:32:24 volumio volumio[1167]: info: Loading i18n strings for locale ru Oct 23 15:32:25 volumio volumio[1167]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Oct 23 15:32:25 volumio volumio[1167]: error: remotepi: Fetching language file: Error: i18n file complementing the system language not found. Oct 23 15:32:25 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:26 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:26 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:26 volumio volumio[1167]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:32:26 volumio volumio[1167]: info: Discovery: Getting this device information Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:32:26 volumio volumio[1167]: info: Discovery: Getting this device information Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:26 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:32:26 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:32:29 volumio volumio[1167]: info: minidlna: Found miniDLNA version 1.2.1 Oct 23 15:32:29 volumio volumio[1167]: info: minidlna: Starting minidlna.service Oct 23 15:32:29 volumio sudo[1920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Oct 23 15:32:29 volumio sudo[1920]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:30 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Oct 23 15:32:30 volumio sudo[1920]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:30 volumio volumio[1167]: info: minidlna: systemctl start minidlna.service succeeded. Oct 23 15:32:30 volumio volumio[1167]: info: Done. Oct 23 15:32:30 volumio volumio[1167]: verbose: New Socket.io Connection to 192.168.0.217 from 192.168.0.24 UA: Mozilla/5.0 (Linux; Android 14; 22081212UG Build/UKQ1.230917.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 23 15:32:30 volumio volumio[1167]: info: Received Get System Info Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:32:30 volumio volumio[1167]: info: Discovery: Getting this device information Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetVisibleSources Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 23 15:32:30 volumio volumio[1167]: info: Received Get System Info Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:32:30 volumio volumio[1167]: info: Discovery: Getting this device information Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:30 volumio volumio[1167]: info: Listing playlists Oct 23 15:32:30 volumio volumio[1167]: info: CoreCommandRouter::volumioGetQueue Oct 23 15:32:30 volumio volumio[1167]: info: CoreStateMachine::getQueue Oct 23 15:32:30 volumio volumio[1167]: info: CorePlayQueue::getQueue Oct 23 15:32:31 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 23 15:32:36 volumio kernel: hwmon hwmon1: Voltage normalised Oct 23 15:32:41 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 23 15:32:46 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 23 15:32:47 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:32:47 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:32:47 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 23 15:32:48 volumio sudo[1935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 23 15:32:48 volumio sudo[1935]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:48 volumio sudo[1941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 23 15:32:48 volumio sudo[1941]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:48 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 23 15:32:48 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 23 15:32:49 volumio sudo[1961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 23 15:32:49 volumio sudo[1961]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:49 volumio sudo[1952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 23 15:32:49 volumio sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:49 volumio sudo[1948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 23 15:32:49 volumio sudo[1957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 23 15:32:49 volumio sudo[1948]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:49 volumio sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:49 volumio sudo[1959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 23 15:32:49 volumio sudo[1959]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:49 volumio sudo[1941]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:49 volumio sudo[1935]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:49 volumio sudo[1959]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:49 volumio sudo[1957]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:49 volumio sudo[1948]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:50 volumio sudo[1952]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:50 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 15:32:50 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 15:32:50 volumio volumio[1167]: info: Discovery: Getting this device information Oct 23 15:32:50 volumio volumio[1167]: info: CoreCommandRouter::volumioGetState Oct 23 15:32:50 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 15:32:51 volumio sudo[1961]: pam_unix(sudo:session): session closed for user root Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:32:53 volumio volumio[1167]: info: Retrieving Cloud Streaming UI Oct 23 15:32:53 volumio volumio[1167]: info: Getting Tidal Cloud Configuration Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:32:53 volumio volumio[1167]: info: Getting Qobuz Cloud Configuration Oct 23 15:32:53 volumio volumio[1167]: info: Asking plugin for UI Config Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:32:53 volumio volumio[1167]: info: Getting Spotify Cloud Configuration Oct 23 15:32:53 volumio volumio[1167]: info: Asking plugin for UI Config Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:32:53 volumio volumio[1167]: info: Saving Spotify Acccount Oct 23 15:32:53 volumio volumio[1167]: info: Got Tidal Cloud Configuration Oct 23 15:32:53 volumio volumio[1167]: info: Got it Oct 23 15:32:53 volumio volumio[1167]: info: Got it Oct 23 15:32:53 volumio volumio[1167]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 15:32:53 volumio volumio[1167]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 15:32:53 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 23 15:32:54 volumio volumio[1167]: info: Disabling MyMusic plugin upnp Oct 23 15:32:55 volumio sudo[1971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 23 15:32:55 volumio sudo[1971]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 15:32:55 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 23 15:32:56 volumio volumio[1167]: info: Enabling MyMusic plugin upnp Oct 23 15:32:56 volumio volumio[1167]: info: Enabling plugin upnp Oct 23 15:32:56 volumio volumio[1167]: info: Loading plugin "upnp"... Oct 23 15:32:56 volumio volumio[1167]: info: [1729679576581] Starting Upmpd Daemon Oct 23 15:32:56 volumio volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 23 15:32:56 volumio volumio[1167]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 15:32:56 volumio volumio[1167]: Error: listen EADDRINUSE: address already in use :::6599 Oct 23 15:32:56 volumio volumio[1167]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Oct 23 15:32:56 volumio volumio[1167]: at listenInCluster (net.js:1366:12) Oct 23 15:32:56 volumio volumio[1167]: at Server.listen (net.js:1452:7) Oct 23 15:32:56 volumio volumio[1167]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 23 15:32:56 volumio volumio[1167]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 23 15:32:56 volumio volumio[1167]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 23 15:32:56 volumio volumio[1167]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 23 15:32:56 volumio volumio[1167]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 23 15:32:56 volumio volumio[1167]: code: 'EADDRINUSE', Oct 23 15:32:56 volumio volumio[1167]: errno: -98, Oct 23 15:32:56 volumio volumio[1167]: syscall: 'listen', Oct 23 15:32:56 volumio volumio[1167]: address: '::', Oct 23 15:32:56 volumio volumio[1167]: port: 6599 Oct 23 15:32:56 volumio volumio[1167]: } Oct 23 15:32:56 volumio volumio[1167]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 15:32:57 volumio sudo[1982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-23 15:31 Oct 23 15:32:57 volumio sudo[1982]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"