Dec 16 12:11:05 volumio sudo[2017]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:11:05 volumio sudo[2017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:05 volumio sudo[2016]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 12:11:05 volumio sudo[2016]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:05 volumio sudo[2017]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:05 volumio sudo[2016]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:06 volumio volumio[1336]: verbose: New Socket.io Connection to 192.168.11.63 from 192.168.11.89 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 OPR/124.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:06 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 12:11:06 volumio volumio[1336]: info: Received Get System Info Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:11:06 volumio volumio[1336]: info: Discovery: Getting this device information Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:06 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:06 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:06 volumio volumio[1336]: info: Listing playlists Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 12:11:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 16 12:11:07 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 12:11:07 volumio volumio[1336]: info: Received Get System Info Dec 16 12:11:07 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:11:07 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:11:07 volumio volumio[1336]: info: Discovery: Getting this device information Dec 16 12:11:07 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:07 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:07 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:11:07 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 16 12:11:07 volumio sudo[2026]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 12:11:07 volumio sudo[2026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:07 volumio sudo[2026]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:07 volumio sudo[2028]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:11:08 volumio sudo[2028]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:08 volumio sudo[2028]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:08 volumio volumio[1336]: verbose: New Socket.io Connection to 192.168.11.63 from 192.168.11.89 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 OPR/124.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:08 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 12:11:08 volumio volumio[1336]: info: Received Get System Info Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:11:08 volumio volumio[1336]: info: Discovery: Getting this device information Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:08 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:11:09 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:09 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:09 volumio volumio[1336]: info: Listing playlists Dec 16 12:11:09 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 12:11:09 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 12:11:09 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 16 12:11:10 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:10 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:10 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 12:11:10 volumio volumio[1336]: info: Received Get System Info Dec 16 12:11:10 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:11:10 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:11:10 volumio volumio[1336]: info: Discovery: Getting this device information Dec 16 12:11:10 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:10 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:10 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:11:10 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 16 12:11:11 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 12:11:14 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 12:11:14 volumio volumio[1336]: info: Received Get System Info Dec 16 12:11:14 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:11:14 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:11:14 volumio volumio[1336]: info: Discovery: Getting this device information Dec 16 12:11:14 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:14 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:14 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:11:14 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 14. Dec 16 12:11:14 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:11:14 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:11:14 volumio upmpdcli[2049]: Could not open config: /tmp/upmpdcli.conf Dec 16 12:11:14 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:11:14 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 16 12:11:18 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 16 12:11:24 volumio volumio[1336]: info: CoreCommandRouter::volumioPlay Dec 16 12:11:24 volumio volumio[1336]: info: CoreStateMachine::play index undefined Dec 16 12:11:24 volumio volumio[1336]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 16 12:11:24 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:24 volumio volumio[1336]: info: CoreStateMachine::startPlaybackTimer Dec 16 12:11:24 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:24 volumio volumio[1336]: info: [1765869084635] ControllerWebradio::clearAddPlayTrack Dec 16 12:11:24 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand stop Dec 16 12:11:24 volumio volumio[1336]: info: sendMpdCommand stop took 4 milliseconds Dec 16 12:11:24 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand clear Dec 16 12:11:24 volumio volumio[1336]: info: Dec 16 12:11:24 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:24 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:24 volumio volumio[1336]: info: sendMpdCommand clear took 60 milliseconds Dec 16 12:11:24 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand load "http://air.volna.top/Retro" Dec 16 12:11:24 volumio volumio[1336]: info: Dec 16 12:11:24 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:24 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:24 volumio volumio[1336]: info: Dec 16 12:11:24 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:24 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:24 volumio volumio[1336]: error: updateQueue error: null Dec 16 12:11:24 volumio volumio[1336]: info: ------------------------------ 118ms Dec 16 12:11:25 volumio volumio[1336]: error: updateQueue error: null Dec 16 12:11:25 volumio volumio[1336]: error: updateQueue error: null Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand add "http://air.volna.top/Retro" Dec 16 12:11:25 volumio volumio[1336]: info: ------------------------------ 368ms Dec 16 12:11:25 volumio volumio[1336]: info: ------------------------------ 366ms Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:25 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand add "http://air.volna.top/Retro" took 4 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand play Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:25 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:25 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:25 volumio volumio[1336]: info: ------------------------------ 92ms Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand play took 56 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: ------------------------------ 47ms Dec 16 12:11:25 volumio volumio[1336]: info: ------------------------------ 38ms Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand status took 55 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand status took 51 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand status took 49 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:25 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:25 volumio volumio[1336]: info: Dec 16 12:11:25 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand status took 186 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 143 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 143 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 143 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand status took 139 milliseconds Dec 16 12:11:25 volumio volumio[1336]: info: sendMpdCommand status took 80 milliseconds Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:25 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:25 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:25 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:25 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus stop Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:25 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:25 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:25 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:25 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:25 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:25 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:25 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:25 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:25 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:25 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:25 volumio volumio[1336]: info: ------------------------------ 624ms Dec 16 12:11:26 volumio volumio[1336]: info: ------------------------------ 769ms Dec 16 12:11:26 volumio volumio[1336]: info: ------------------------------ 767ms Dec 16 12:11:26 volumio volumio[1336]: info: Dec 16 12:11:26 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:26 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:26 volumio volumio[1336]: info: Dec 16 12:11:26 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:26 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:26 volumio volumio[1336]: info: Dec 16 12:11:26 volumio volumio[1336]: ---------------------------- MPD announces system playlist update Dec 16 12:11:26 volumio volumio[1336]: info: Ignoring MPD Status Update Dec 16 12:11:26 volumio volumio[1336]: info: Dec 16 12:11:26 volumio volumio[1336]: ---------------------------- MPD announces state update: player Dec 16 12:11:26 volumio volumio[1336]: info: ControllerMpd::getState Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand status Dec 16 12:11:26 volumio volumio[1336]: info: ------------------------------ 680ms Dec 16 12:11:26 volumio volumio[1336]: info: sendMpdCommand status took 630 milliseconds Dec 16 12:11:26 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 623 milliseconds Dec 16 12:11:26 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 481 milliseconds Dec 16 12:11:26 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 453 milliseconds Dec 16 12:11:26 volumio volumio[1336]: info: ------------------------------ 100ms Dec 16 12:11:26 volumio volumio[1336]: info: sendMpdCommand status took 98 milliseconds Dec 16 12:11:26 volumio volumio[1336]: info: ------------------------------ 96ms Dec 16 12:11:26 volumio volumio[1336]: info: sendMpdCommand status took 47 milliseconds Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::parseState Dec 16 12:11:26 volumio volumio[1336]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 16 12:11:26 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:26 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:26 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:26 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:26 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:26 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:26 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:26 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:26 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:26 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:26 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:26 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:26 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:26 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:26 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:26 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:27 volumio volumio[1336]: info: ------------------------------ 1737ms Dec 16 12:11:27 volumio volumio[1336]: info: ------------------------------ 1736ms Dec 16 12:11:27 volumio volumio[1336]: info: ------------------------------ 1734ms Dec 16 12:11:27 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 1408 milliseconds Dec 16 12:11:27 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 1406 milliseconds Dec 16 12:11:27 volumio volumio[1336]: info: sendMpdCommand playlistinfo took 1361 milliseconds Dec 16 12:11:27 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:27 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:27 volumio volumio[1336]: verbose: ControllerMpd::parseTrackInfo Dec 16 12:11:27 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:27 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:27 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1107,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:27 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:27 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:27 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:27 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:27 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1611,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:27 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:27 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:27 volumio volumio[1336]: info: ControllerMpd::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Dec 16 12:11:27 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Dec 16 12:11:27 volumio volumio[1336]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"МУРАТ НАСЫРОВ - ЛОВИЛА НА ГУБЫ","artist":null,"album":null,"uri":"http://air.volna.top/Retro","trackType":"top/Retro"} Dec 16 12:11:27 volumio volumio[1336]: verbose: CURRENT POSITION 0 Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::syncState stateService play Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::syncState currentStatus play Dec 16 12:11:27 volumio volumio[1336]: info: Received an update from plugin. extracting info from payload Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreStateMachine::pushState Dec 16 12:11:27 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Dec 16 12:11:28 volumio volumio[1336]: info: ------------------------------ 2819ms Dec 16 12:11:28 volumio volumio[1336]: info: ------------------------------ 2253ms Dec 16 12:11:28 volumio volumio[1336]: info: ------------------------------ 2250ms Dec 16 12:11:28 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 12:11:28 volumio volumio[1336]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 16 12:11:28 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 16 12:11:28 volumio volumio[1336]: info: Received Get System Version Dec 16 12:11:28 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 12:11:28 volumio volumio[1336]: info: Received Get System Info Dec 16 12:11:28 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:11:28 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:11:28 volumio volumio[1336]: info: Discovery: Getting this device information Dec 16 12:11:28 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:28 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:11:29 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 15. Dec 16 12:11:29 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:11:30 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:11:30 volumio upmpdcli[2070]: Could not open config: /tmp/upmpdcli.conf Dec 16 12:11:30 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:11:30 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 16 12:11:33 volumio volumio[1336]: info: CoreCommandRouter::volumioGetQueue Dec 16 12:11:33 volumio volumio[1336]: info: CoreStateMachine::getQueue Dec 16 12:11:33 volumio volumio[1336]: info: CorePlayQueue::getQueue Dec 16 12:11:37 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:41 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:44 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:45 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 16. Dec 16 12:11:45 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:11:45 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:11:45 volumio upmpdcli[2100]: Could not open config: /tmp/upmpdcli.conf Dec 16 12:11:45 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:11:45 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 16 12:11:48 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 12:11:48 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 16 12:11:52 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Dec 16 12:11:56 volumio volumio[1336]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 12:11:56 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 16 12:11:56 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 16 12:11:57 volumio sudo[2148]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:11:57 volumio sudo[2130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 16 12:11:57 volumio sudo[2148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:57 volumio sudo[2148]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:57 volumio sudo[2135]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 16 12:11:57 volumio sudo[2135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:57 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 16 12:11:57 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 16 12:11:57 volumio sudo[2135]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:57 volumio sudo[2130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:57 volumio sudo[2126]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 16 12:11:57 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:57 volumio sudo[2130]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:57 volumio sudo[2141]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 16 12:11:57 volumio sudo[2141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:57 volumio sudo[2154]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 16 12:11:57 volumio sudo[2154]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:57 volumio sudo[2146]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 12:11:57 volumio sudo[2146]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:11:57 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:57 volumio sudo[2141]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:57 volumio sudo[2146]: pam_unix(sudo:session): session closed for user root Dec 16 12:11:58 volumio sudo[2154]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:00 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 17. Dec 16 12:12:00 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:12:00 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:12:00 volumio upmpdcli[2160]: Could not open config: /tmp/upmpdcli.conf Dec 16 12:12:00 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:12:00 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 16 12:12:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Dec 16 12:12:08 volumio volumio[1336]: info: Saving new wireless network Dec 16 12:12:08 volumio sudo[2177]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Dec 16 12:12:08 volumio sudo[2177]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:08 volumio sudo[2177]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:08 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 16 12:12:08 volumio volumio[1336]: info: Discovery: Restarting Advertising due to device name change Dec 16 12:12:08 volumio sudo[2180]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 16 12:12:08 volumio sudo[2180]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:08 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 16 12:12:08 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 16 12:12:08 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 16 12:12:08 volumio systemd[1]: wireless.service: Consumed 9min 4.968s CPU time. Dec 16 12:12:08 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 16 12:12:09 volumio volumio[1336]: info: Discovery: A device disappeared from network Dec 16 12:12:09 volumio volumio[1336]: info: Discovery: Device volumio disappeared from network Dec 16 12:12:09 volumio volumio[1336]: info: Discovery: A device disappeared from network Dec 16 12:12:09 volumio sudo[2195]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:12:09 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:09 volumio sudo[2195]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:09 volumio wireless.js[2184]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 16 12:12:09 volumio wireless.js[2184]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 16 12:12:09 volumio wireless.js[2184]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 16 12:12:09 volumio wireless.js[2184]: WIRELESS.JS: Cleaning previous... Dec 16 12:12:10 volumio sudo[2205]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 16 12:12:10 volumio sudo[2205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:12:10 volumio sudo[2205]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:10 volumio sudo[2207]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 16 12:12:10 volumio sudo[2207]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:12:10 volumio sudo[2207]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:10 volumio sudo[2210]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:12:10 volumio sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:10 volumio sudo[2210]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:10 volumio wireless.js[2184]: WIRELESS.JS: Stopped aP Dec 16 12:12:11 volumio sudo[2218]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 16 12:12:11 volumio sudo[2218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:11 volumio sudo[2218]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:11 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 16 12:12:11 volumio sudo[2220]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 16 12:12:11 volumio sudo[2220]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:11 volumio sudo[2220]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:11 volumio sudo[2228]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 16 12:12:11 volumio sudo[2228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:11 volumio sudo[2228]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:11 volumio sudo[2230]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 16 12:12:11 volumio sudo[2230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:11 volumio sudo[2235]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:12:11 volumio sudo[2235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:11 volumio sudo[2235]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:12 volumio sudo[2230]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:12 volumio wireless.js[2184]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: RU Dec 16 12:12:12 volumio sudo[2239]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 16 12:12:12 volumio sudo[2239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:12 volumio sudo[2239]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:12 volumio sudo[2241]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set RU Dec 16 12:12:12 volumio sudo[2241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:12 volumio sudo[2241]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:12 volumio wireless.js[2184]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: RU Dec 16 12:12:12 volumio wireless.js[2184]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Dec 16 12:12:12 volumio wireless.js[2184]: WIRELESS.JS: Notified systemd about wireless ready Dec 16 12:12:12 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 16 12:12:12 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 16 12:12:12 volumio sudo[2248]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:12:12 volumio sudo[2180]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:12 volumio sudo[2248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:12 volumio sudo[2248]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:13 volumio volumio[1336]: info: Discovery: Started advertising with name: Volumio Dec 16 12:12:13 volumio sudo[2253]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:12:13 volumio sudo[2253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:12:13 volumio sudo[2253]: pam_unix(sudo:session): session closed for user root Dec 16 12:12:14 volumio volumio[1336]: compat.c: read() failed: Resource temporarily unavailable Dec 16 12:12:14 volumio volumio[1336]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 12:12:14 volumio volumio[1336]: Error: dns service error: unknown Dec 16 12:12:14 volumio volumio[1336]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 16 12:12:14 volumio volumio[1336]: errorCode: -65537 Dec 16 12:12:14 volumio volumio[1336]: } Dec 16 12:12:14 volumio volumio[1336]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 12:12:15 volumio sudo[2284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-16 12:11' Dec 16 12:12:15 volumio sudo[2284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"