Dec 28 14:27:46 volumio volumio[1197]: info: CorePlayQueue::getTrack 0
Dec 28 14:27:46 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:46 volumio volumio[1197]: info: Prefetching next song
Dec 28 14:27:46 volumio volumio[1197]: info: Doing Prefetch in UPNP
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.10:50002/m/MP3/65297.mp3"
Dec 28 14:27:46 volumio volumio[1197]: info:
Dec 28 14:27:46 volumio volumio[1197]: ---------------------------- MPD announces system playlist update
Dec 28 14:27:46 volumio volumio[1197]: info: Ignoring MPD Status Update
Dec 28 14:27:46 volumio volumio[1197]: info: sendMpdCommand add "http://192.168.1.10:50002/m/MP3/65297.mp3" took 42 milliseconds
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand consume 1
Dec 28 14:27:46 volumio volumio[1197]: info:
Dec 28 14:27:46 volumio volumio[1197]: ---------------------------- MPD announces system playlist update
Dec 28 14:27:46 volumio volumio[1197]: info: Ignoring MPD Status Update
Dec 28 14:27:46 volumio volumio[1197]: info:
Dec 28 14:27:46 volumio volumio[1197]: ---------------------------- MPD announces system playlist update
Dec 28 14:27:46 volumio volumio[1197]: info: Ignoring MPD Status Update
Dec 28 14:27:46 volumio volumio[1197]: info:
Dec 28 14:27:46 volumio volumio[1197]: ---------------------------- MPD announces state update: options
Dec 28 14:27:46 volumio volumio[1197]: info: ------------------------------ 114ms
Dec 28 14:27:46 volumio volumio[1197]: info: sendMpdCommand consume 1 took 75 milliseconds
Dec 28 14:27:46 volumio volumio[1197]: info: ControllerMpd::getState
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand status
Dec 28 14:27:46 volumio volumio[1197]: info:
Dec 28 14:27:46 volumio volumio[1197]: ---------------------------- MPD announces state update: options
Dec 28 14:27:46 volumio volumio[1197]: info: ControllerMpd::getState
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand status
Dec 28 14:27:46 volumio volumio[1197]: info: ------------------------------ 186ms
Dec 28 14:27:46 volumio volumio[1197]: info: ------------------------------ 154ms
Dec 28 14:27:46 volumio volumio[1197]: info: sendMpdCommand status took 150 milliseconds
Dec 28 14:27:46 volumio volumio[1197]: info: sendMpdCommand status took 149 milliseconds
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::parseState
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::parseState
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 28 14:27:46 volumio volumio[1197]: info:
Dec 28 14:27:46 volumio volumio[1197]: ---------------------------- MPD announces state update: options
Dec 28 14:27:46 volumio volumio[1197]: info: ControllerMpd::getState
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand status
Dec 28 14:27:46 volumio volumio[1197]: info: sendMpdCommand playlistinfo took 125 milliseconds
Dec 28 14:27:46 volumio volumio[1197]: info: sendMpdCommand playlistinfo took 49 milliseconds
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::parseTrackInfo
Dec 28 14:27:46 volumio volumio[1197]: verbose: ControllerMpd::parseTrackInfo
Dec 28 14:27:46 volumio volumio[1197]: info: ControllerMpd::pushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreCommandRouter::servicePushState
Dec 28 14:27:46 volumio volumio[1197]: info: CorePlayQueue::getTrack 0
Dec 28 14:27:46 volumio volumio[1197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211340,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Kochaj mnie","artist":"Armia","album":"Legenda","uri":"http://192.168.1.10:50002/m/MP3/65293.mp3","trackType":"mp3"}
Dec 28 14:27:46 volumio volumio[1197]: verbose: CURRENT POSITION 0
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::syncState stateService play
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::syncState currentStatus play
Dec 28 14:27:46 volumio volumio[1197]: info: Received an update from plugin. extracting info from payload
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 28 14:27:46 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:46 volumio volumio[1197]: info: ControllerMpd::pushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreCommandRouter::servicePushState
Dec 28 14:27:46 volumio volumio[1197]: info: CorePlayQueue::getTrack 0
Dec 28 14:27:46 volumio volumio[1197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211340,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Kochaj mnie","artist":"Armia","album":"Legenda","uri":"http://192.168.1.10:50002/m/MP3/65293.mp3","trackType":"mp3"}
Dec 28 14:27:46 volumio volumio[1197]: verbose: CURRENT POSITION 0
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::syncState stateService play
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::syncState currentStatus play
Dec 28 14:27:46 volumio volumio[1197]: info: Received an update from plugin. extracting info from payload
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:46 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:47 volumio volumio[1197]: info: ------------------------------ 688ms
Dec 28 14:27:47 volumio volumio[1197]: info: ------------------------------ 687ms
Dec 28 14:27:47 volumio volumio[1197]: info: sendMpdCommand status took 413 milliseconds
Dec 28 14:27:47 volumio volumio[1197]: verbose: ControllerMpd::parseState
Dec 28 14:27:47 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: sendMpdCommand playlistinfo took 239 milliseconds
Dec 28 14:27:47 volumio volumio[1197]: verbose: ControllerMpd::parseTrackInfo
Dec 28 14:27:47 volumio volumio[1197]: info: ControllerMpd::pushState
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::servicePushState
Dec 28 14:27:47 volumio volumio[1197]: info: CorePlayQueue::getTrack 0
Dec 28 14:27:47 volumio volumio[1197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211592,"duration":216,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Kochaj mnie","artist":"Armia","album":"Legenda","uri":"http://192.168.1.10:50002/m/MP3/65293.mp3","trackType":"mp3"}
Dec 28 14:27:47 volumio volumio[1197]: verbose: CURRENT POSITION 0
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::syncState stateService play
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::syncState currentStatus play
Dec 28 14:27:47 volumio volumio[1197]: info: Received an update from plugin. extracting info from payload
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:47 volumio volumio[1197]: info: ------------------------------ 855ms
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:47 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:50 volumio volumio[1197]: info: CoreStateMachine::startPlaybackTimer
Dec 28 14:27:50 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:50 volumio volumio[1197]: info:
Dec 28 14:27:50 volumio volumio[1197]: ---------------------------- MPD announces system playlist update
Dec 28 14:27:50 volumio volumio[1197]: info: Ignoring MPD Status Update
Dec 28 14:27:50 volumio volumio[1197]: info:
Dec 28 14:27:50 volumio volumio[1197]: ---------------------------- MPD announces state update: player
Dec 28 14:27:50 volumio volumio[1197]: info: ControllerMpd::getState
Dec 28 14:27:50 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand status
Dec 28 14:27:50 volumio volumio[1197]: info:
Dec 28 14:27:50 volumio volumio[1197]: ---------------------------- MPD announces system playlist update
Dec 28 14:27:50 volumio volumio[1197]: info: Ignoring MPD Status Update
Dec 28 14:27:50 volumio volumio[1197]: info:
Dec 28 14:27:50 volumio volumio[1197]: ---------------------------- MPD announces state update: player
Dec 28 14:27:50 volumio volumio[1197]: info: ControllerMpd::getState
Dec 28 14:27:50 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand status
Dec 28 14:27:50 volumio volumio[1197]: info:
Dec 28 14:27:50 volumio volumio[1197]: ---------------------------- MPD announces system playlist update
Dec 28 14:27:50 volumio volumio[1197]: info: Ignoring MPD Status Update
Dec 28 14:27:50 volumio volumio[1197]: info:
Dec 28 14:27:50 volumio volumio[1197]: ---------------------------- MPD announces state update: player
Dec 28 14:27:50 volumio volumio[1197]: info: ControllerMpd::getState
Dec 28 14:27:50 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand status
Dec 28 14:27:50 volumio volumio[1197]: info: ------------------------------ 7ms
Dec 28 14:27:50 volumio volumio[1197]: info: sendMpdCommand status took 5 milliseconds
Dec 28 14:27:50 volumio volumio[1197]: info: ------------------------------ 5ms
Dec 28 14:27:50 volumio volumio[1197]: info: sendMpdCommand status took 4 milliseconds
Dec 28 14:27:50 volumio volumio[1197]: verbose: ControllerMpd::parseState
Dec 28 14:27:50 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 28 14:27:50 volumio volumio[1197]: verbose: ControllerMpd::parseState
Dec 28 14:27:50 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 28 14:27:51 volumio volumio[1197]: info: ------------------------------ 114ms
Dec 28 14:27:51 volumio volumio[1197]: info: sendMpdCommand status took 113 milliseconds
Dec 28 14:27:51 volumio volumio[1197]: info: sendMpdCommand playlistinfo took 48 milliseconds
Dec 28 14:27:51 volumio volumio[1197]: info: sendMpdCommand playlistinfo took 48 milliseconds
Dec 28 14:27:51 volumio volumio[1197]: verbose: ControllerMpd::parseState
Dec 28 14:27:51 volumio volumio[1197]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 28 14:27:51 volumio volumio[1197]: verbose: ControllerMpd::parseTrackInfo
Dec 28 14:27:51 volumio volumio[1197]: verbose: ControllerMpd::parseTrackInfo
Dec 28 14:27:51 volumio volumio[1197]: info: ControllerMpd::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::servicePushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":183,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Przeblysk","artist":"Armia","album":"Legenda","uri":"http://192.168.1.10:50002/m/MP3/65297.mp3","trackType":"mp3"}
Dec 28 14:27:51 volumio volumio[1197]: verbose: CURRENT POSITION 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::syncState stateService play
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::syncState currentStatus play
Dec 28 14:27:51 volumio volumio[1197]: info: Received an update from plugin. extracting info from payload
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:51 volumio volumio[1197]: info: ControllerMpd::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::servicePushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":183,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Przeblysk","artist":"Armia","album":"Legenda","uri":"http://192.168.1.10:50002/m/MP3/65297.mp3","trackType":"mp3"}
Dec 28 14:27:51 volumio volumio[1197]: verbose: CURRENT POSITION 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::syncState stateService play
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::syncState currentStatus play
Dec 28 14:27:51 volumio volumio[1197]: info: Received an update from plugin. extracting info from payload
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:51 volumio volumio[1197]: info: ------------------------------ 510ms
Dec 28 14:27:51 volumio volumio[1197]: info: ------------------------------ 548ms
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:51 volumio volumio[1197]: info: sendMpdCommand playlistinfo took 505 milliseconds
Dec 28 14:27:51 volumio volumio[1197]: verbose: ControllerMpd::parseTrackInfo
Dec 28 14:27:51 volumio volumio[1197]: info: ControllerMpd::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::servicePushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":183,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Przeblysk","artist":"Armia","album":"Legenda","uri":"http://192.168.1.10:50002/m/MP3/65297.mp3","trackType":"mp3"}
Dec 28 14:27:51 volumio volumio[1197]: verbose: CURRENT POSITION 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::syncState stateService play
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::syncState currentStatus play
Dec 28 14:27:51 volumio volumio[1197]: info: Received an update from plugin. extracting info from payload
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::pushState
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getTrack 1
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioPushState
Dec 28 14:27:51 volumio volumio[1197]: info: ------------------------------ 768ms
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreCommandRouter::volumioGetQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CoreStateMachine::getQueue
Dec 28 14:27:51 volumio volumio[1197]: info: CorePlayQueue::getQueue
Dec 28 14:27:56 volumio volumio[1197]: info: CALLMETHOD: system_controller network saveHotspotSettings [object Object]
Dec 28 14:27:56 volumio volumio[1197]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings
Dec 28 14:27:57 volumio sudo[2465]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf
Dec 28 14:27:57 volumio sudo[2465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:27:57 volumio sudo[2465]: pam_unix(sudo:session): session closed for user root
Dec 28 14:27:57 volumio volumio[1197]: info: Permissions for /etc/hostapd/hostapd.conf
Dec 28 14:27:58 volumio volumio[1197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Dec 28 14:27:58 volumio volumio[1197]: info: Discovery: Restarting Advertising due to device name change
Dec 28 14:27:58 volumio sudo[2468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Dec 28 14:27:58 volumio sudo[2468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:27:58 volumio systemd[1]: Stopping wireless.service - Wireless Services...
Dec 28 14:27:58 volumio systemd[1]: wireless.service: Deactivated successfully.
Dec 28 14:27:58 volumio systemd[1]: Stopped wireless.service - Wireless Services.
Dec 28 14:27:58 volumio systemd[1]: wireless.service: Consumed 7min 56.998s CPU time.
Dec 28 14:27:58 volumio systemd[1]: Starting wireless.service - Wireless Services...
Dec 28 14:27:59 volumio volumio[1197]: info: Discovery: A device disappeared from network
Dec 28 14:27:59 volumio volumio[1197]: info: Discovery: Device volumio disappeared from network
Dec 28 14:27:59 volumio volumio[1197]: info: Discovery: A device disappeared from network
Dec 28 14:28:00 volumio wireless.js[2475]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless
Dec 28 14:28:00 volumio wireless.js[2475]: WIRELESS.JS: Wired network status changed to: ---connected---
Dec 28 14:28:00 volumio wireless.js[2475]: WIRELESS.JS: Wireless.js initializing wireless flow
Dec 28 14:28:00 volumio wireless.js[2475]: WIRELESS.JS: Cleaning previous...
Dec 28 14:28:00 volumio sudo[2507]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0
Dec 28 14:28:00 volumio sudo[2507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 28 14:28:00 volumio sudo[2507]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:00 volumio sudo[2509]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down
Dec 28 14:28:00 volumio sudo[2509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 28 14:28:00 volumio sudo[2509]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:01 volumio wireless.js[2475]: WIRELESS.JS: Stopped aP
Dec 28 14:28:01 volumio sudo[2519]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Dec 28 14:28:01 volumio sudo[2519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:28:01 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Dec 28 14:28:01 volumio sudo[2519]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:01 volumio sudo[2521]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Dec 28 14:28:01 volumio sudo[2521]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:28:01 volumio sudo[2521]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:01 volumio sudo[2529]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Dec 28 14:28:01 volumio sudo[2529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:28:01 volumio sudo[2529]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:01 volumio sudo[2531]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Dec 28 14:28:01 volumio sudo[2531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:28:02 volumio sudo[2531]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:02 volumio wireless.js[2475]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: DE
Dec 28 14:28:02 volumio sudo[2539]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Dec 28 14:28:02 volumio sudo[2539]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:28:02 volumio sudo[2539]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:02 volumio sudo[2541]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE
Dec 28 14:28:02 volumio sudo[2541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 28 14:28:02 volumio sudo[2541]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:02 volumio wireless.js[2475]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: DE
Dec 28 14:28:02 volumio wireless.js[2475]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow
Dec 28 14:28:02 volumio wireless.js[2475]: WIRELESS.JS: Notified systemd about wireless ready
Dec 28 14:28:02 volumio systemd[1]: Started wireless.service - Wireless Services.
Dec 28 14:28:02 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Dec 28 14:28:02 volumio sudo[2468]: pam_unix(sudo:session): session closed for user root
Dec 28 14:28:03 volumio volumio[1197]: info: Discovery: Started advertising with name: Volumio
Dec 28 14:28:03 volumio volumio[1197]: compat.c: read() failed: Resource temporarily unavailable
Dec 28 14:28:03 volumio volumio[1197]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 28 14:28:04 volumio volumio[1197]: Error: dns service error: unknown
Dec 28 14:28:04 volumio volumio[1197]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Dec 28 14:28:04 volumio volumio[1197]: errorCode: -65537
Dec 28 14:28:04 volumio volumio[1197]: }
Dec 28 14:28:04 volumio volumio[1197]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 28 14:28:08 volumio sudo[2582]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-28 14:27'
Dec 28 14:28:08 volumio sudo[2582]: 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"