Feb 11 22:38:00 volumio systemd[1]: wireless.service: Deactivated successfully. Feb 11 22:38:00 volumio systemd[1]: Stopped wireless.service - Wireless Services. Feb 11 22:38:00 volumio systemd[1]: wireless.service: Consumed 1.911s CPU time. Feb 11 22:38:00 volumio systemd[1]: Starting wireless.service - Wireless Services... Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: === SNM TRANSITION === Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: New ethernet state: connected Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: Single Network Mode: enabled Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: First start: yes Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: === END TRANSITION === Feb 11 22:38:00 volumio wireless.js[9397]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Feb 11 22:38:00 volumio sudo[9417]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:00 volumio sudo[9417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:00 volumio sudo[9417]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:00 volumio sudo[9424]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 11 22:38:00 volumio sudo[9424]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:00 volumio sudo[9424]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:00 volumio sudo[9426]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 11 22:38:00 volumio sudo[9426]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:01 volumio sudo[9426]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:01 volumio wireless.js[9397]: WIRELESS.JS - INFO: Cleaning previous... Feb 11 22:38:01 volumio sudo[9429]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 11 22:38:01 volumio sudo[9429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:01 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 11 22:38:01 volumio sudo[9429]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:01 volumio wireless.js[9397]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Feb 11 22:38:01 volumio wireless.js[9397]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 4ms Feb 11 22:38:01 volumio wireless.js[9397]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:28:ac:41) Feb 11 22:38:01 volumio sudo[9436]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 11 22:38:01 volumio sudo[9436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:01 volumio sudo[9436]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:01 volumio sudo[9444]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 11 22:38:01 volumio sudo[9444]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:01 volumio sudo[9449]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:01 volumio sudo[9449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:01 volumio sudo[9449]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:02 volumio sudo[9452]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:02 volumio sudo[9452]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:02 volumio sudo[9452]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:03 volumio sudo[9455]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:03 volumio sudo[9455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:03 volumio sudo[9455]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:04 volumio sudo[9444]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: Regdomain already correct: RU Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active Feb 11 22:38:04 volumio sudo[9462]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 11 22:38:04 volumio sudo[9462]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:04 volumio sudo[9462]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:04 volumio sudo[9465]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 11 22:38:04 volumio sudo[9465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:04 volumio sudo[9465]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:04 volumio wpa_supplicant[9468]: Successfully initialized wpa_supplicant Feb 11 22:38:04 volumio wpa_supplicant[9468]: nl80211: kernel reports: Registration to specific type not supported Feb 11 22:38:04 volumio wpa_supplicant[9471]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 3820ms Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: wlan0 state: wpa_state=SCANNING (expected DISCONNECTED or INACTIVE) Feb 11 22:38:04 volumio wireless.js[9397]: WIRELESS.JS - INFO: Notified systemd about wireless ready Feb 11 22:38:04 volumio systemd[1]: Started wireless.service - Wireless Services. Feb 11 22:38:04 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 11 22:38:04 volumio sudo[9395]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:04 volumio sudo[9488]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:04 volumio sudo[9488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:04 volumio sudo[9488]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:05 volumio sudo[9506]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:05 volumio sudo[9506]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:05 volumio sudo[9506]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:06 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 22:38:06 volumio volumio[1181]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 11 22:38:06 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 11 22:38:06 volumio volumio[1181]: info: Received Get System Version Feb 11 22:38:06 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 11 22:38:06 volumio volumio[1181]: info: Received Get System Info Feb 11 22:38:06 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:38:06 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:38:06 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:38:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:06 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:38:06 volumio sudo[9509]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:06 volumio sudo[9509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:06 volumio sudo[9509]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:07 volumio sudo[9512]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:07 volumio sudo[9512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:07 volumio sudo[9512]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:08 volumio sudo[9515]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:08 volumio sudo[9515]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:08 volumio sudo[9515]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Feb 11 22:38:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Feb 11 22:38:09 volumio sudo[9518]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:09 volumio sudo[9518]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:09 volumio sudo[9518]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:09 volumio volumio[1181]: info: Discovery: Networking Restart detected, restarting advertisement and browsing Feb 11 22:38:09 volumio volumio[1181]: info: Discovery: Restarting Advertising Feb 11 22:38:09 volumio volumio[1181]: info: Discovery: Stopping existing advertisement Feb 11 22:38:09 volumio volumio[1181]: info: Discovery: Restarting Browsing Feb 11 22:38:09 volumio sudo[9521]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:09 volumio sudo[9521]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:09 volumio sudo[9521]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:10 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:38:10 volumio volumio[1181]: info: Discovery: Device volumio disappeared from network Feb 11 22:38:10 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:38:10 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:38:10 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:38:10 volumio sudo[9524]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:10 volumio sudo[9524]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:10 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:38:10 volumio sudo[9524]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:10 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:38:11 volumio sudo[9527]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:11 volumio sudo[9527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:11 volumio sudo[9527]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:12 volumio sudo[9530]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:12 volumio sudo[9530]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:12 volumio sudo[9530]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:13 volumio sudo[9533]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:13 volumio sudo[9533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:13 volumio sudo[9533]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio volumio[1181]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 22:38:14 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 11 22:38:14 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 11 22:38:14 volumio sudo[9539]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 11 22:38:14 volumio sudo[9539]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9544]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:38:14 volumio sudo[9544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9544]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio sudo[9550]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:38:14 volumio sudo[9550]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9554]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:38:14 volumio sudo[9554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9539]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio sudo[9550]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio sudo[9554]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Feb 11 22:38:14 volumio sudo[9561]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:38:14 volumio sudo[9561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Feb 11 22:38:14 volumio volumio[1181]: info: Refreshing Cached IP Addresses Feb 11 22:38:14 volumio sudo[9561]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio sudo[9567]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:14 volumio sudo[9567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9567]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio sudo[9570]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Feb 11 22:38:14 volumio sudo[9570]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio volumio[1181]: info: Discovery: Started advertising with name: Volumio Feb 11 22:38:14 volumio sudo[9574]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:38:14 volumio sudo[9574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9570]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio sudo[9574]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio sudo[9575]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:14 volumio sudo[9575]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9575]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:14 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 11 22:38:14 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 11 22:38:14 volumio sudo[9582]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 11 22:38:14 volumio sudo[9582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9584]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:14 volumio sudo[9584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:14 volumio sudo[9584]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9602]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:38:15 volumio sudo[9602]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9604]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:15 volumio sudo[9602]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9604]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio volumio[1181]: verbose: New Socket.io Connection to 192.168.1.239 from 192.168.1.222 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 11 22:38:15 volumio systemd[1]: upmpdcli.service: Deactivated successfully. Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetVisibleSources Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 11 22:38:15 volumio volumio[1181]: info: Received Get System Info Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Listing playlists Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 11 22:38:15 volumio sudo[9617]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:38:15 volumio sudo[9617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9612]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 11 22:38:15 volumio sudo[9612]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9617]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9623]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:38:15 volumio sudo[9612]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 11 22:38:15 volumio sudo[9623]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9627]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:38:15 volumio sudo[9627]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9636]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:15 volumio sudo[9636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9627]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9633]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:38:15 volumio sudo[9636]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9633]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio sudo[9641]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 11 22:38:15 volumio sudo[9641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9641]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio volumio[1181]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 11 22:38:15 volumio volumio[1181]: wlan0 Interface doesn't support scanning : Device or resource busy Feb 11 22:38:15 volumio volumio[1181]: info: Cannot use regular scanning, forcing with ap-force Feb 11 22:38:15 volumio sudo[9649]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 11 22:38:15 volumio sudo[9649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9649]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:15 volumio volumio[1181]: command failed: Device or resource busy (-16) Feb 11 22:38:15 volumio volumio[1181]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 11 22:38:15 volumio volumio[1181]: command failed: Device or resource busy (-16) Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: adding c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:38:15 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:38:15 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:15 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:15 volumio sudo[9660]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:15 volumio sudo[9660]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:15 volumio sudo[9660]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:16 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 11 22:38:16 volumio sudo[9663]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:16 volumio sudo[9663]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:16 volumio sudo[9663]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 22:38:17 volumio volumio[1181]: info: Received Get System Info Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:38:17 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:17 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:38:17 volumio sudo[9582]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 22:38:17 volumio volumio[1181]: info: Received Get System Info Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:38:17 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:17 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:17 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:38:17 volumio sudo[9666]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:17 volumio sudo[9666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:17 volumio sudo[9666]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:18 volumio sudo[9669]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:18 volumio sudo[9669]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:18 volumio sudo[9669]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:19 volumio sudo[9672]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:19 volumio sudo[9672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:19 volumio sudo[9672]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:20 volumio sudo[9675]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:20 volumio sudo[9675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:20 volumio sudo[9675]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:21 volumio sudo[9678]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:21 volumio sudo[9678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:21 volumio sudo[9678]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:22 volumio sudo[9681]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:22 volumio sudo[9681]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:22 volumio sudo[9681]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:23 volumio sudo[9684]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:23 volumio sudo[9684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:23 volumio sudo[9684]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:24 volumio sudo[9687]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:38:24 volumio sudo[9687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:24 volumio sudo[9689]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:24 volumio sudo[9689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:24 volumio sudo[9687]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:24 volumio sudo[9689]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:24 volumio sudo[9691]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:24 volumio sudo[9691]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:24 volumio sudo[9691]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:24 volumio sudo[9695]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 11 22:38:24 volumio sudo[9695]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 11 22:38:25 volumio sudo[9713]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:25 volumio sudo[9713]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:25 volumio sudo[9713]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:26 volumio sudo[9717]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:26 volumio sudo[9717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:26 volumio sudo[9717]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:27 volumio sudo[9720]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:27 volumio sudo[9720]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:27 volumio sudo[9720]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:28 volumio sudo[9723]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:28 volumio sudo[9723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:28 volumio sudo[9723]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:29 volumio sudo[9726]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:29 volumio sudo[9726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:29 volumio sudo[9726]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:30 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6. Feb 11 22:38:30 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 11 22:38:30 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 11 22:38:30 volumio sudo[9695]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:30 volumio volumio[1181]: info: Upmpdcli Daemon Started Feb 11 22:38:30 volumio upmpdcli[9744]: writing RSA key Feb 11 22:38:33 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 22:38:33 volumio volumio[1181]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 11 22:38:33 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 11 22:38:33 volumio volumio[1181]: info: Received Get System Version Feb 11 22:38:33 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 11 22:38:33 volumio volumio[1181]: info: Received Get System Info Feb 11 22:38:33 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:38:33 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:38:33 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:38:33 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:38:33 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:38:33 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:38:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Feb 11 22:38:50 volumio volumio[1181]: info: Saving new wireless network Feb 11 22:38:50 volumio sudo[9779]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Feb 11 22:38:50 volumio sudo[9779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:50 volumio sudo[9779]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Feb 11 22:38:50 volumio sudo[9782]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Feb 11 22:38:50 volumio sudo[9782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:50 volumio systemd[1]: Stopping wireless.service - Wireless Services... Feb 11 22:38:50 volumio systemd[1]: wireless.service: Killing process 9471 (wpa_supplicant) with signal SIGKILL. Feb 11 22:38:50 volumio systemd[1]: wireless.service: Deactivated successfully. Feb 11 22:38:50 volumio systemd[1]: Stopped wireless.service - Wireless Services. Feb 11 22:38:50 volumio systemd[1]: wireless.service: Consumed 1.892s CPU time. Feb 11 22:38:50 volumio systemd[1]: Starting wireless.service - Wireless Services... Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: === SNM TRANSITION === Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: New ethernet state: connected Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: Single Network Mode: enabled Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: First start: yes Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: === END TRANSITION === Feb 11 22:38:51 volumio wireless.js[9784]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Feb 11 22:38:51 volumio sudo[9804]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:51 volumio sudo[9804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:51 volumio sudo[9804]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:51 volumio sudo[9811]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 11 22:38:51 volumio sudo[9811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:51 volumio sudo[9811]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:51 volumio sudo[9813]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 11 22:38:51 volumio sudo[9813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:52 volumio sudo[9813]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:52 volumio wireless.js[9784]: WIRELESS.JS - INFO: Cleaning previous... Feb 11 22:38:52 volumio sudo[9816]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 11 22:38:52 volumio sudo[9816]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:52 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 11 22:38:52 volumio sudo[9816]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:52 volumio wireless.js[9784]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Feb 11 22:38:52 volumio wireless.js[9784]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 3ms Feb 11 22:38:52 volumio wireless.js[9784]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:28:ac:41) Feb 11 22:38:52 volumio sudo[9823]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 11 22:38:52 volumio sudo[9823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:52 volumio sudo[9823]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:52 volumio sudo[9831]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 11 22:38:52 volumio sudo[9831]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:52 volumio sudo[9836]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:52 volumio sudo[9836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:52 volumio sudo[9836]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:53 volumio sudo[9839]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:53 volumio sudo[9839]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:53 volumio sudo[9839]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:54 volumio sudo[9842]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:54 volumio sudo[9842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:54 volumio sudo[9842]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:54 volumio sudo[9831]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:54 volumio wireless.js[9784]: WIRELESS.JS - INFO: Regdomain already correct: RU Feb 11 22:38:54 volumio wireless.js[9784]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability Feb 11 22:38:54 volumio wireless.js[9784]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) Feb 11 22:38:54 volumio wireless.js[9784]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active Feb 11 22:38:54 volumio sudo[9849]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 11 22:38:54 volumio sudo[9849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:54 volumio sudo[9849]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:54 volumio sudo[9852]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 11 22:38:54 volumio sudo[9852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:38:54 volumio sudo[9852]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:54 volumio wpa_supplicant[9855]: Successfully initialized wpa_supplicant Feb 11 22:38:55 volumio wpa_supplicant[9855]: nl80211: kernel reports: Registration to specific type not supported Feb 11 22:38:55 volumio wpa_supplicant[9872]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 11 22:38:55 volumio wireless.js[9784]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 3876ms Feb 11 22:38:55 volumio wireless.js[9784]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable Feb 11 22:38:55 volumio wireless.js[9784]: WIRELESS.JS - INFO: Notified systemd about wireless ready Feb 11 22:38:55 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 11 22:38:55 volumio systemd[1]: Started wireless.service - Wireless Services. Feb 11 22:38:55 volumio sudo[9782]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:55 volumio sudo[9889]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:55 volumio sudo[9889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:55 volumio sudo[9889]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:56 volumio sudo[9892]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:56 volumio sudo[9892]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:56 volumio sudo[9892]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:57 volumio sudo[9895]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:57 volumio sudo[9895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:57 volumio sudo[9895]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:58 volumio sudo[9898]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:58 volumio sudo[9898]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:58 volumio sudo[9898]: pam_unix(sudo:session): session closed for user root Feb 11 22:38:59 volumio sudo[9902]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:38:59 volumio sudo[9902]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:38:59 volumio sudo[9902]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:00 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Feb 11 22:39:00 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Feb 11 22:39:00 volumio volumio[1181]: info: Discovery: Networking Restart detected, restarting advertisement and browsing Feb 11 22:39:00 volumio volumio[1181]: info: Discovery: Restarting Advertising Feb 11 22:39:00 volumio volumio[1181]: info: Discovery: Stopping existing advertisement Feb 11 22:39:00 volumio volumio[1181]: info: Discovery: Restarting Browsing Feb 11 22:39:00 volumio sudo[9905]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:00 volumio sudo[9905]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:00 volumio sudo[9905]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:00 volumio sudo[9908]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:00 volumio sudo[9908]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:00 volumio sudo[9908]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: Device volumio disappeared from network Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:01 volumio sudo[9911]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:01 volumio sudo[9911]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:01 volumio sudo[9911]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:01 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:02 volumio sudo[9914]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:02 volumio sudo[9914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:02 volumio sudo[9914]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:03 volumio sudo[9917]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:03 volumio sudo[9917]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:03 volumio sudo[9917]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:04 volumio sudo[9920]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:04 volumio sudo[9920]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:04 volumio sudo[9920]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:05 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Feb 11 22:39:05 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Feb 11 22:39:05 volumio volumio[1181]: info: Refreshing Cached IP Addresses Feb 11 22:39:05 volumio sudo[9937]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Feb 11 22:39:05 volumio sudo[9937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:05 volumio volumio[1181]: info: Discovery: Started advertising with name: Volumio Feb 11 22:39:05 volumio sudo[9939]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:39:05 volumio sudo[9939]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:05 volumio sudo[9937]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:05 volumio sudo[9939]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:05 volumio sudo[9941]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:05 volumio sudo[9941]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:05 volumio sudo[9941]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:05 volumio sudo[9948]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:05 volumio sudo[9948]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:05 volumio sudo[9948]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:05 volumio systemd[1]: upmpdcli.service: Deactivated successfully. Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: adding c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: this is already registered, c4d68bc0-f9ab-4eba-ba9c-1eeb8c2c5df9 Feb 11 22:39:06 volumio volumio[1181]: info: Discovery: Found device Volumio Feb 11 22:39:06 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:06 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:06 volumio sudo[9961]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:06 volumio sudo[9961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:06 volumio sudo[9961]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:07 volumio sudo[9964]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:07 volumio sudo[9964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:07 volumio sudo[9964]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio sudo[9967]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:39:08 volumio sudo[9967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[9967]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio sudo[9969]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:08 volumio sudo[9969]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[9969]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio volumio[1181]: verbose: New Socket.io Connection to 192.168.1.239 from 192.168.1.222 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::volumioGetVisibleSources Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:08 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 11 22:39:08 volumio volumio[1181]: info: Received Get System Info Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:39:08 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:08 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:08 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:08 volumio volumio[1181]: info: Listing playlists Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 11 22:39:08 volumio sudo[9976]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 11 22:39:08 volumio sudo[9976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[9981]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:39:08 volumio sudo[9981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[9981]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio sudo[9976]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio sudo[9987]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:39:08 volumio sudo[9987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 11 22:39:08 volumio sudo[9987]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 11 22:39:08 volumio sudo[10000]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:39:08 volumio sudo[9993]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 11 22:39:08 volumio sudo[9993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[10000]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[10000]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio sudo[9993]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 11 22:39:08 volumio sudo[10003]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:08 volumio sudo[10003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[10003]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:08 volumio sudo[10007]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 11 22:39:08 volumio sudo[10007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[10011]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:08 volumio sudo[10011]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:08 volumio sudo[10011]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:09 volumio sudo[10014]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:09 volumio sudo[10014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:09 volumio sudo[10014]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 11 22:39:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 22:39:09 volumio volumio[1181]: info: Received Get System Info Feb 11 22:39:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:39:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:39:09 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:39:09 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:09 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:39:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 11 22:39:10 volumio sudo[10017]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:10 volumio sudo[10017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:10 volumio sudo[10017]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:10 volumio sudo[10007]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:11 volumio sudo[10020]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:11 volumio sudo[10020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:11 volumio sudo[10020]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:12 volumio sudo[10023]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:12 volumio sudo[10023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:12 volumio sudo[10023]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:12 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 22:39:12 volumio volumio[1181]: info: Received Get System Info Feb 11 22:39:12 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:39:12 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:39:12 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:39:12 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:12 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:12 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 22:39:13 volumio volumio[1181]: info: Received Get System Info Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:39:13 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:13 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 22:39:13 volumio volumio[1181]: info: Received Get System Info Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 22:39:13 volumio volumio[1181]: info: Discovery: Getting this device information Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState Feb 11 22:39:13 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:13 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 22:39:13 volumio sudo[10026]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:13 volumio sudo[10026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:13 volumio sudo[10026]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:14 volumio sudo[10029]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:14 volumio sudo[10029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:14 volumio sudo[10029]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:15 volumio sudo[10046]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:15 volumio sudo[10046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:15 volumio sudo[10048]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:39:15 volumio sudo[10048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:15 volumio sudo[10046]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:15 volumio sudo[10050]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:15 volumio sudo[10048]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:15 volumio sudo[10050]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:15 volumio sudo[10050]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:15 volumio sudo[10055]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 11 22:39:15 volumio sudo[10055]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:16 volumio sudo[10058]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:16 volumio sudo[10058]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:16 volumio sudo[10058]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:17 volumio sudo[10061]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:17 volumio sudo[10061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:17 volumio sudo[10061]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:18 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 11 22:39:18 volumio sudo[10064]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:18 volumio sudo[10064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:18 volumio sudo[10064]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:19 volumio sudo[10068]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:19 volumio sudo[10068]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:19 volumio sudo[10068]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:20 volumio sudo[10071]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:20 volumio sudo[10071]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:20 volumio sudo[10071]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:20 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Feb 11 22:39:20 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 11 22:39:20 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 11 22:39:20 volumio sudo[10055]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:20 volumio volumio[1181]: info: Upmpdcli Daemon Started Feb 11 22:39:21 volumio upmpdcli[10089]: writing RSA key Feb 11 22:39:34 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Feb 11 22:39:34 volumio volumio[1181]: info: Saving new wireless network Feb 11 22:39:35 volumio sudo[10112]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Feb 11 22:39:35 volumio sudo[10112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:35 volumio sudo[10112]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:35 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Feb 11 22:39:35 volumio sudo[10115]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Feb 11 22:39:35 volumio sudo[10115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:35 volumio systemd[1]: Stopping wireless.service - Wireless Services... Feb 11 22:39:35 volumio systemd[1]: wireless.service: Killing process 9872 (wpa_supplicant) with signal SIGKILL. Feb 11 22:39:35 volumio systemd[1]: wireless.service: Deactivated successfully. Feb 11 22:39:35 volumio systemd[1]: Stopped wireless.service - Wireless Services. Feb 11 22:39:35 volumio systemd[1]: wireless.service: Consumed 1.821s CPU time. Feb 11 22:39:35 volumio systemd[1]: Starting wireless.service - Wireless Services... Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: === SNM TRANSITION === Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: New ethernet state: connected Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: Single Network Mode: enabled Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: First start: yes Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: === END TRANSITION === Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Feb 11 22:39:36 volumio sudo[10148]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:36 volumio sudo[10148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:36 volumio sudo[10148]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:36 volumio sudo[10157]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 11 22:39:36 volumio sudo[10157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:39:36 volumio sudo[10157]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:36 volumio sudo[10159]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 11 22:39:36 volumio sudo[10159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:39:36 volumio sudo[10159]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: Cleaning previous... Feb 11 22:39:36 volumio sudo[10163]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 11 22:39:36 volumio sudo[10163]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:39:36 volumio sudo[10163]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:36 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 3ms Feb 11 22:39:36 volumio wireless.js[10131]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:28:ac:41) Feb 11 22:39:36 volumio sudo[10170]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 11 22:39:36 volumio sudo[10170]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:37 volumio sudo[10170]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:37 volumio sudo[10178]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 11 22:39:37 volumio sudo[10178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:37 volumio sudo[10183]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:37 volumio sudo[10183]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:37 volumio sudo[10183]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:38 volumio sudo[10186]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:38 volumio sudo[10186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:38 volumio sudo[10186]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:39 volumio sudo[10190]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:39 volumio sudo[10190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:39 volumio sudo[10190]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:39 volumio sudo[10178]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:39 volumio wireless.js[10131]: WIRELESS.JS - INFO: Regdomain already correct: RU Feb 11 22:39:39 volumio wireless.js[10131]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability Feb 11 22:39:39 volumio wireless.js[10131]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) Feb 11 22:39:39 volumio wireless.js[10131]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active Feb 11 22:39:39 volumio sudo[10197]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 11 22:39:39 volumio sudo[10197]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:39:39 volumio sudo[10197]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:39 volumio sudo[10200]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 11 22:39:39 volumio sudo[10200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 22:39:39 volumio sudo[10200]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:39 volumio wpa_supplicant[10203]: Successfully initialized wpa_supplicant Feb 11 22:39:39 volumio wpa_supplicant[10203]: nl80211: kernel reports: Registration to specific type not supported Feb 11 22:39:39 volumio wpa_supplicant[10206]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 11 22:39:40 volumio wireless.js[10131]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 3935ms Feb 11 22:39:40 volumio wireless.js[10131]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable Feb 11 22:39:40 volumio sudo[10225]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:40 volumio sudo[10225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:40 volumio sudo[10225]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:40 volumio wireless.js[10131]: WIRELESS.JS - INFO: Notified systemd about wireless ready Feb 11 22:39:40 volumio systemd[1]: Started wireless.service - Wireless Services. Feb 11 22:39:40 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 11 22:39:40 volumio sudo[10115]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:41 volumio sudo[10229]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:41 volumio sudo[10229]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:41 volumio sudo[10229]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:42 volumio sudo[10232]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:42 volumio sudo[10232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:42 volumio sudo[10232]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:43 volumio sudo[10235]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:43 volumio sudo[10235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:43 volumio sudo[10235]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:44 volumio sudo[10238]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:44 volumio sudo[10238]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:44 volumio sudo[10238]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:45 volumio volumio[1181]: info: Discovery: Networking Restart detected, restarting advertisement and browsing Feb 11 22:39:45 volumio volumio[1181]: info: Discovery: Restarting Advertising Feb 11 22:39:45 volumio volumio[1181]: info: Discovery: Stopping existing advertisement Feb 11 22:39:45 volumio volumio[1181]: info: Discovery: Restarting Browsing Feb 11 22:39:45 volumio sudo[10241]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:45 volumio sudo[10241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:45 volumio sudo[10241]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:45 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Feb 11 22:39:45 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Feb 11 22:39:45 volumio sudo[10244]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:45 volumio sudo[10244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:45 volumio sudo[10244]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: Device volumio disappeared from network Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio sudo[10261]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio sudo[10261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio sudo[10261]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:46 volumio volumio[1181]: info: Discovery: A device disappeared from network Feb 11 22:39:47 volumio sudo[10265]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:47 volumio sudo[10265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:47 volumio sudo[10265]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:48 volumio sudo[10268]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:48 volumio sudo[10268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:48 volumio sudo[10268]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:48 volumio volumio[1181]: info: CoreCommandRouter::volumioPlay Feb 11 22:39:48 volumio volumio[1181]: info: CoreStateMachine::play index undefined Feb 11 22:39:48 volumio volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 22:39:48 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:48 volumio volumio[1181]: info: CoreStateMachine::startPlaybackTimer Feb 11 22:39:48 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:48 volumio volumio[1181]: info: [1770838788538] ControllerWebradio::clearAddPlayTrack Feb 11 22:39:48 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 22:39:48 volumio volumio[1181]: info: sendMpdCommand stop took 3 milliseconds Feb 11 22:39:48 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 22:39:48 volumio volumio[1181]: info: sendMpdCommand clear took 1 milliseconds Feb 11 22:39:48 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" Feb 11 22:39:48 volumio volumio[1181]: info: Feb 11 22:39:48 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:48 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:48 volumio volumio[1181]: info: Feb 11 22:39:48 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:48 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:48 volumio volumio[1181]: info: Feb 11 22:39:48 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:48 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:48 volumio volumio[1181]: info: Feb 11 22:39:48 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:48 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:48 volumio volumio[1181]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" took 370 milliseconds Feb 11 22:39:48 volumio volumio[1181]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 22:39:48 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand play Feb 11 22:39:48 volumio volumio[1181]: info: ------------------------------ 375ms Feb 11 22:39:48 volumio volumio[1181]: info: ------------------------------ 373ms Feb 11 22:39:48 volumio volumio[1181]: info: ------------------------------ 371ms Feb 11 22:39:48 volumio volumio[1181]: info: ------------------------------ 8ms Feb 11 22:39:48 volumio volumio[1181]: info: Feb 11 22:39:48 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:48 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:48 volumio volumio[1181]: info: Feb 11 22:39:48 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:48 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:48 volumio volumio[1181]: info: sendMpdCommand play took 11 milliseconds Feb 11 22:39:48 volumio volumio[1181]: info: ------------------------------ 4ms Feb 11 22:39:48 volumio volumio[1181]: info: ------------------------------ 4ms Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio sudo[10277]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio sudo[10277]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 6 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio sudo[10277]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 11 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 9 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1552/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:49 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 26ms Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1552/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:49 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:49 volumio volumio[1181]: info: Received an update from plugin. extracting info from payload Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1552/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:49 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:49 volumio volumio[1181]: info: Received an update from plugin. extracting info from payload Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 70ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 69ms Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 61 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 62 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 12 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 13 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand clearerror took 41 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand clearerror took 41 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand clearerror took 39 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand clearerror took 39 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 27 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 26 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 25 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 24 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 23 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":1,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1552/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:49 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::play index undefined Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::startPlaybackTimer Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: [1770838789290] ControllerWebradio::clearAddPlayTrack Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 165ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 165ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 115ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 112ms Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 66 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 66 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand stop took 13 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 115ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 114ms Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:49 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand clear took 41 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:49 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:49 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:49 volumio volumio[1181]: error: updateQueue error: null Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 20ms Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:49 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" took 143 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 142ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 140ms Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand play Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:49 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:49 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 7ms Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand play took 4 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 4ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 2ms Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: Feb 11 22:39:49 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 3 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 2 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand status took 3 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1534/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:49 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1534/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:49 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:49 volumio volumio[1181]: info: Received an update from plugin. extracting info from payload Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 20ms Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 30ms Feb 11 22:39:49 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 25 milliseconds Feb 11 22:39:49 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:49 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1534/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:49 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:49 volumio volumio[1181]: info: Received an update from plugin. extracting info from payload Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:49 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:49 volumio volumio[1181]: info: ------------------------------ 57ms Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 8 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 17 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 16 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clearerror took 12 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 12 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 12 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 10 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 10 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":1,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1534/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:50 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::play index undefined Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::startPlaybackTimer Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: [1770838790099] ControllerWebradio::clearAddPlayTrack Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 57ms Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: Discovery: Started advertising with name: Volumio Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clearerror took 102 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clearerror took 102 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 95 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 95 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 94 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 95 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 94 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand stop took 67 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio sudo[10289]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio sudo[10289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:50 volumio sudo[10289]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 180ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 179ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 179ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 172ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 170ms Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Feb 11 22:39:50 volumio volumio[1181]: info: Refreshing Cached IP Addresses Feb 11 22:39:50 volumio sudo[10292]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Feb 11 22:39:50 volumio sudo[10292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clear took 93 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" Feb 11 22:39:50 volumio sudo[10294]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 22:39:50 volumio sudo[10294]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:50 volumio sudo[10292]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:50 volumio sudo[10296]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 22:39:50 volumio sudo[10296]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 22:39:50 volumio sudo[10294]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:50 volumio sudo[10296]: pam_unix(sudo:session): session closed for user root Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: error: updateQueue error: null Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 145ms Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" took 143 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand play Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 114ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 113ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 3ms Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand play took 5 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 2ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 1ms Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 3 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 2 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 2 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1527/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:50 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1527/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:50 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:50 volumio volumio[1181]: info: Received an update from plugin. extracting info from payload Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 17ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 24ms Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 20 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: verbose: STATE SERVICE {"status":"play","position":1,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1527/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:50 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState stateService play Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:50 volumio volumio[1181]: info: Received an update from plugin. extracting info from payload Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 45ms Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 7 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces state update: player Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::getState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 15 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 14 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clearerror took 11 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 10 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 8 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand status took 7 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseState Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":1,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldie-antenne","artist":"(#2 - 1527/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldie-antenne","trackType":""} Feb 11 22:39:50 volumio volumio[1181]: verbose: CURRENT POSITION 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus play Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::play index undefined Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::startPlaybackTimer Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: [1770838790765] ControllerWebradio::clearAddPlayTrack Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 48ms Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clearerror took 50 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clearerror took 49 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 44 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 43 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 44 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 43 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand playlistinfo took 43 milliseconds Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand stop took 21 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::parseTrackInfo Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ControllerMpd::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::servicePushState Feb 11 22:39:50 volumio volumio[1181]: info: CoreStateMachine::pushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState Feb 11 22:39:50 volumio volumio[1181]: info: CorePlayQueue::getTrack 0 Feb 11 22:39:50 volumio volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 108ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 107ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 108ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 101ms Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 101ms Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: info: sendMpdCommand clear took 53 milliseconds Feb 11 22:39:50 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: info: Feb 11 22:39:50 volumio volumio[1181]: ---------------------------- MPD announces system playlist update Feb 11 22:39:50 volumio volumio[1181]: info: Ignoring MPD Status Update Feb 11 22:39:50 volumio volumio[1181]: error: updateQueue error: null Feb 11 22:39:50 volumio volumio[1181]: info: ------------------------------ 14ms Feb 11 22:39:50 volumio volumio[1181]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 22:39:50 volumio volumio[1181]: AggregateError Feb 11 22:39:50 volumio volumio[1181]: at internalConnectMultiple (node:net:1114:18) Feb 11 22:39:50 volumio volumio[1181]: at afterConnectMultiple (node:net:1667:5) { Feb 11 22:39:50 volumio volumio[1181]: code: 'EHOSTUNREACH', Feb 11 22:39:50 volumio volumio[1181]: [errors]: [ Feb 11 22:39:50 volumio volumio[1181]: Error: connect EHOSTUNREACH 2.16.21.9:443 Feb 11 22:39:50 volumio volumio[1181]: at createConnectionError (node:net:1634:14) Feb 11 22:39:50 volumio volumio[1181]: at afterConnectMultiple (node:net:1664:40) { Feb 11 22:39:50 volumio volumio[1181]: errno: -113, Feb 11 22:39:50 volumio volumio[1181]: code: 'EHOSTUNREACH', Feb 11 22:39:50 volumio volumio[1181]: syscall: 'connect', Feb 11 22:39:50 volumio volumio[1181]: address: '2.16.21.9', Feb 11 22:39:50 volumio volumio[1181]: port: 443 Feb 11 22:39:50 volumio volumio[1181]: }, Feb 11 22:39:50 volumio volumio[1181]: Error: connect EHOSTUNREACH 2.16.21.56:443 Feb 11 22:39:50 volumio volumio[1181]: at createConnectionError (node:net:1634:14) Feb 11 22:39:50 volumio volumio[1181]: at afterConnectMultiple (node:net:1664:40) { Feb 11 22:39:50 volumio volumio[1181]: errno: -113, Feb 11 22:39:50 volumio volumio[1181]: code: 'EHOSTUNREACH', Feb 11 22:39:50 volumio volumio[1181]: syscall: 'connect', Feb 11 22:39:50 volumio volumio[1181]: address: '2.16.21.56', Feb 11 22:39:50 volumio volumio[1181]: port: 443 Feb 11 22:39:50 volumio volumio[1181]: } Feb 11 22:39:50 volumio volumio[1181]: ] Feb 11 22:39:50 volumio volumio[1181]: } Feb 11 22:39:50 volumio volumio[1181]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 22:39:50 volumio systemd[1]: upmpdcli.service: Deactivated successfully. Feb 11 22:39:51 volumio sudo[10315]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 22:38' Feb 11 22:39:51 volumio sudo[10315]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"