Dec 29 21:27:02 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:06 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:10 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:14 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:18 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:22 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:26 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:30 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:34 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:38 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:42 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:46 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:48 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand rescan Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: info: Dec 29 21:27:48 volumio volumio[1099]: ---------------------------- MPD announces state update: update Dec 29 21:27:48 volumio volumio[1099]: info: sendMpdCommand rescan took 30 milliseconds Dec 29 21:27:48 volumio volumio[1099]: info: ControllerMpd::getState Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: info: Dec 29 21:27:48 volumio volumio[1099]: ---------------------------- MPD announces state update: update Dec 29 21:27:48 volumio volumio[1099]: info: ControllerMpd::getState Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: info: Dec 29 21:27:48 volumio volumio[1099]: ---------------------------- MPD announces state update: update Dec 29 21:27:48 volumio volumio[1099]: info: ControllerMpd::getState Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: info: Dec 29 21:27:48 volumio volumio[1099]: ---------------------------- MPD announces state update: update Dec 29 21:27:48 volumio volumio[1099]: info: ControllerMpd::getState Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:48 volumio volumio[1099]: info: sendMpdCommand status took 75 milliseconds Dec 29 21:27:48 volumio volumio[1099]: info: sendMpdCommand status took 73 milliseconds Dec 29 21:27:48 volumio volumio[1099]: info: sendMpdCommand status took 73 milliseconds Dec 29 21:27:48 volumio volumio[1099]: info: sendMpdCommand status took 114 milliseconds Dec 29 21:27:48 volumio volumio[1099]: info: sendMpdCommand status took 113 milliseconds Dec 29 21:27:48 volumio volumio[1099]: info: sendMpdCommand status took 50 milliseconds Dec 29 21:27:48 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: info: Command Router : Notfying DB Updatefalse Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: info: Command Router : Notfying DB Updatefalse Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: info: Command Router : Notfying DB Updatefalse Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: info: ControllerMpd::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::servicePushState Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 29 21:27:49 volumio volumio[1099]: verbose: CURRENT POSITION 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::syncState stateService stop Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: No code Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: ControllerMpd::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::servicePushState Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 29 21:27:49 volumio volumio[1099]: verbose: CURRENT POSITION 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::syncState stateService stop Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: No code Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: ControllerMpd::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::servicePushState Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 29 21:27:49 volumio volumio[1099]: verbose: CURRENT POSITION 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::syncState stateService stop Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: No code Dec 29 21:27:49 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:49 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:49 volumio volumio[1099]: info: ------------------------------ 946ms Dec 29 21:27:49 volumio volumio[1099]: info: ------------------------------ 949ms Dec 29 21:27:49 volumio volumio[1099]: info: ------------------------------ 948ms Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:49 volumio volumio[1099]: info: Dec 29 21:27:49 volumio volumio[1099]: ---------------------------- MPD announces state update: update Dec 29 21:27:49 volumio volumio[1099]: info: ControllerMpd::getState Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:49 volumio volumio[1099]: info: Dec 29 21:27:49 volumio volumio[1099]: ---------------------------- MPD announces state update: update Dec 29 21:27:49 volumio volumio[1099]: info: ControllerMpd::getState Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:27:49 volumio volumio[1099]: info: sendMpdCommand status took 910 milliseconds Dec 29 21:27:49 volumio volumio[1099]: info: sendMpdCommand status took 908 milliseconds Dec 29 21:27:49 volumio volumio[1099]: info: sendMpdCommand status took 21 milliseconds Dec 29 21:27:49 volumio volumio[1099]: info: sendMpdCommand status took 20 milliseconds Dec 29 21:27:49 volumio volumio[1099]: info: sendMpdCommand status took 19 milliseconds Dec 29 21:27:49 volumio volumio[1099]: info: sendMpdCommand status took 4 milliseconds Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: info: Command Router : Notfying DB Updatefalse Dec 29 21:27:49 volumio volumio[1099]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:49 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:50 volumio volumio[1099]: info: Command Router : Notfying DB Updatefalse Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:27:50 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:50 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:50 volumio volumio[1099]: info: Command Router : Notfying DB Updatefalse Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:27:50 volumio volumio[1099]: verbose: ControllerMpd::parseState Dec 29 21:27:50 volumio volumio[1099]: info: ControllerMpd::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::servicePushState Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 29 21:27:50 volumio volumio[1099]: verbose: CURRENT POSITION 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::syncState stateService stop Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: No code Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: ControllerMpd::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::servicePushState Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 29 21:27:50 volumio volumio[1099]: verbose: CURRENT POSITION 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::syncState stateService stop Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: No code Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: ControllerMpd::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::servicePushState Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 29 21:27:50 volumio volumio[1099]: verbose: CURRENT POSITION 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::syncState stateService stop Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: No code Dec 29 21:27:50 volumio volumio[1099]: info: CoreStateMachine::pushState Dec 29 21:27:50 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::volumioPushState Dec 29 21:27:50 volumio volumio[1099]: info: ------------------------------ 1602ms Dec 29 21:27:50 volumio volumio[1099]: info: ------------------------------ 713ms Dec 29 21:27:50 volumio volumio[1099]: info: ------------------------------ 710ms Dec 29 21:27:50 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:54 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:27:58 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:28:02 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 21:28:07 volumio volumio[1099]: info: CoreCommandRouter::volumioGetState Dec 29 21:28:07 volumio volumio[1099]: info: CorePlayQueue::getTrack 0 Dec 29 21:28:07 volumio systemd[1]: Starting apt-daily-upgrade.service - Daily apt upgrade and clean activities... Dec 29 21:28:08 volumio systemd[1]: apt-daily-upgrade.service: Deactivated successfully. Dec 29 21:28:08 volumio systemd[1]: Finished apt-daily-upgrade.service - Daily apt upgrade and clean activities. Dec 29 21:28:10 volumio volumio[1099]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 29 21:28:10 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 29 21:28:10 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 29 21:28:11 volumio sudo[2136]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 29 21:28:11 volumio sudo[2136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2136]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio sudo[2141]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 21:28:11 volumio sudo[2141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2141]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 29 21:28:11 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 29 21:28:11 volumio sudo[2147]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 21:28:11 volumio sudo[2147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2147]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio sudo[2153]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 21:28:11 volumio sudo[2153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2153]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio sudo[2159]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 21:28:11 volumio sudo[2159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2159]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio sudo[2162]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 21:28:11 volumio sudo[2162]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2166]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 29 21:28:11 volumio sudo[2162]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio sudo[2166]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2166]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio volumio[1099]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 29 21:28:11 volumio volumio[1099]: wlan0 Interface doesn't support scanning : Network is down Dec 29 21:28:11 volumio volumio[1099]: info: Cannot use regular scanning, forcing with ap-force Dec 29 21:28:11 volumio sudo[2172]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 29 21:28:11 volumio sudo[2172]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:11 volumio sudo[2172]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:11 volumio volumio[1099]: command failed: Network is down (-100) Dec 29 21:28:11 volumio volumio[1099]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 29 21:28:11 volumio volumio[1099]: command failed: Network is down (-100) Dec 29 21:28:17 volumio volumio[1099]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Dec 29 21:28:17 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Dec 29 21:28:17 volumio sudo[2193]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Dec 29 21:28:17 volumio sudo[2193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:17 volumio sudo[2193]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:17 volumio sudo[2195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Dec 29 21:28:17 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:17 volumio sudo[2195]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:17 volumio volumio[1099]: info: Permissions for /etc/network/interfaces set Dec 29 21:28:17 volumio volumio[1099]: info: Restarting Wireless Network Dec 29 21:28:17 volumio volumio[1099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 29 21:28:17 volumio volumio[1099]: info: Discovery: Restarting Advertising due to device name change Dec 29 21:28:17 volumio sudo[2198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 29 21:28:17 volumio sudo[2198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:17 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 29 21:28:17 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 29 21:28:17 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 29 21:28:17 volumio systemd[1]: wireless.service: Consumed 7min 31.226s CPU time. Dec 29 21:28:17 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 29 21:28:18 volumio wireless.js[2204]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 29 21:28:18 volumio wireless.js[2204]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 29 21:28:18 volumio volumio[1099]: info: Discovery: A device disappeared from network Dec 29 21:28:18 volumio volumio[1099]: info: Discovery: Device volumio disappeared from network Dec 29 21:28:18 volumio wireless.js[2204]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 29 21:28:18 volumio wireless.js[2204]: WIRELESS.JS: Cleaning previous... Dec 29 21:28:18 volumio volumio[1099]: info: Discovery: A device disappeared from network Dec 29 21:28:18 volumio sudo[2222]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 29 21:28:18 volumio sudo[2222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 29 21:28:18 volumio sudo[2222]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:18 volumio sudo[2224]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 29 21:28:18 volumio sudo[2224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 29 21:28:18 volumio sudo[2224]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:19 volumio wireless.js[2204]: WIRELESS.JS: Stopped aP Dec 29 21:28:19 volumio sudo[2232]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 29 21:28:19 volumio sudo[2232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 21:28:19 volumio sudo[2232]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:19 volumio wireless.js[2204]: SIOCSIFFLAGS: Operation not possible due to RF-kill Dec 29 21:28:19 volumio wireless.js[2204]: WIRELESS.JS: Failed to determine most appropriate reg domain: Error: Command failed: /usr/bin/sudo /sbin/ifconfig wlan0 up && /usr/bin/sudo /sbin/iw reg get | grep country | cut -f1 -d':' Dec 29 21:28:19 volumio wireless.js[2204]: SIOCSIFFLAGS: Operation not possible due to RF-kill Dec 29 21:28:19 volumio wireless.js[2204]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Dec 29 21:28:19 volumio wireless.js[2204]: WIRELESS.JS: Notified systemd about wireless ready Dec 29 21:28:19 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 29 21:28:19 volumio sudo[2198]: pam_unix(sudo:session): session closed for user root Dec 29 21:28:22 volumio volumio[1099]: info: Discovery: Started advertising with name: Volumio Dec 29 21:28:23 volumio volumio[1099]: compat.c: read() failed: Resource temporarily unavailable Dec 29 21:28:23 volumio volumio[1099]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 21:28:23 volumio volumio[1099]: Error: dns service error: unknown Dec 29 21:28:23 volumio volumio[1099]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 29 21:28:23 volumio volumio[1099]: errorCode: -65537 Dec 29 21:28:23 volumio volumio[1099]: } Dec 29 21:28:23 volumio volumio[1099]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 21:28:24 volumio sudo[2267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-29 21:27' Dec 29 21:28:24 volumio sudo[2267]: 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"