-- Logs begin at Sun 2024-02-18 12:01:04 CET, end at Mon 2024-04-15 12:15:33 CEST. --
Apr 15 12:14:01 primo sudo[9939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 15 12:14:01 primo sudo[9939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:01 primo sudo[9939]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:01 primo sudo[9941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 15 12:14:01 primo sudo[9941]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:01 primo sudo[9941]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:01 primo volumio[5490]: verbose: New Socket.io Connection to 192.168.178.30 from 192.168.178.52 UA: okhttp/4.9.2 Total Clients: 9
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:01 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 15 12:14:01 primo volumio[5490]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Apr 15 12:14:01 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:01 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:01 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:01 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 15 12:14:01 primo volumio[5490]: info: Listing playlists
Apr 15 12:14:01 primo sudo[9948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 15 12:14:01 primo sudo[9948]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:01 primo sudo[9948]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:02 primo sudo[9951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 15 12:14:02 primo sudo[9951]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:02 primo sudo[9951]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:02 primo volumio[5490]: verbose: New Socket.io Connection to 192.168.178.30 from 192.168.178.52 UA: okhttp/4.9.2 Total Clients: 9
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:02 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 15 12:14:02 primo volumio[5490]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Apr 15 12:14:02 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:02 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:02 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:02 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:02 primo volumio[5490]: info: Listing playlists
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 15 12:14:02 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 15 12:14:02 primo volumio[5490]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 9
Apr 15 12:14:03 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:03 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:03 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 15 12:14:03 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:03 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:03 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:03 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:03 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:03 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:03 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:04 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:04 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:04 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 15 12:14:04 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:04 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:04 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:04 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:04 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:04 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:04 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:05 primo volumio[5490]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 10
Apr 15 12:14:07 primo volumio[5490]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 11
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 15 12:14:07 primo volumio[5490]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Apr 15 12:14:07 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:07 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: Listing playlists
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 15 12:14:07 primo volumio[5490]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Apr 15 12:14:07 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:07 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: Listing playlists
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 15 12:14:07 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:07 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:07 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:09 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Apr 15 12:14:11 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 15 12:14:11 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:11 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:11 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:11 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:11 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:11 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:11 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:12 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:12 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:12 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 15 12:14:12 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:12 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:12 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:12 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:12 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:12 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:12 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:20 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 15 12:14:20 primo volumio[5490]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Apr 15 12:14:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Apr 15 12:14:20 primo volumio[5490]: info: Received Get System Version
Apr 15 12:14:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 15 12:14:20 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:20 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:20 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:20 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:23 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 15 12:14:23 primo volumio[5490]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Apr 15 12:14:23 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Apr 15 12:14:23 primo volumio[5490]: info: Received Get System Version
Apr 15 12:14:23 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 15 12:14:23 primo volumio[5490]: info: Received Get System Info
Apr 15 12:14:23 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:23 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:23 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:23 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:23 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:24 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:24 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 12:14:24 primo volumio[5490]: info: Discovery: Getting this device information
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:14:24 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:14:24 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 12:14:25 primo volumio[5490]: info: Discovery: A device disappeared from network
Apr 15 12:14:28 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:31 primo volumio[5490]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 15 12:14:31 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 15 12:14:32 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Apr 15 12:14:32 primo sudo[10138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Apr 15 12:14:32 primo sudo[10138]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:32 primo sudo[10143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 15 12:14:32 primo sudo[10143]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:32 primo sudo[10138]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:32 primo sudo[10149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 15 12:14:32 primo sudo[10149]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:32 primo sudo[10143]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:32 primo sudo[10149]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:32 primo sudo[10162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 15 12:14:32 primo sudo[10162]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:32 primo sudo[10155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 15 12:14:32 primo sudo[10155]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:32 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 15 12:14:32 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 15 12:14:32 primo sudo[10162]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:32 primo sudo[10155]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:32 primo sudo[10168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 15 12:14:32 primo sudo[10168]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:32 primo sudo[10168]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:32 primo sudo[10173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 15 12:14:32 primo sudo[10173]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:14:32 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:32 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:32 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:32 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:33 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:34 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:35 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:35 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:35 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:36 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:36 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:36 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:36 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 8
Apr 15 12:14:36 primo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc002835000 drv_status 0x0 e_type 69 e_states 0
Apr 15 12:14:36 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:36 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:36 primo sudo[10173]: pam_unix(sudo:session): session closed for user root
Apr 15 12:14:42 primo ntpd[9320]: 75.119.140.230 local addr 192.168.178.30 ->
Apr 15 12:14:44 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:44 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:52 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:14:52 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:00 primo volumio[5490]: info: CALLMETHOD: system_controller network saveHotspotSettings [object Object]
Apr 15 12:15:00 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings
Apr 15 12:15:00 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:00 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:01 primo sudo[10228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf
Apr 15 12:15:01 primo sudo[10228]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:01 primo sudo[10228]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:01 primo volumio[5490]: info: Permissions for /etc/hostapd/hostapd.conf
Apr 15 12:15:01 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Apr 15 12:15:01 primo volumio[5490]: info: Discovery: Restarting Advertising due to device name change
Apr 15 12:15:01 primo sudo[10231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Apr 15 12:15:01 primo sudo[10231]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:01 primo wpa_supplicant[9219]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory
Apr 15 12:15:01 primo wpa_supplicant[9219]: nl80211: Failed to set IPv4 unicast in multicast filter
Apr 15 12:15:01 primo systemd[1]: Stopping Wireless Services...
Apr 15 12:15:01 primo wpa_supplicant[9219]: nl80211: Failed to open /proc/sys/net/ipv4/conf/p2p-dev-wlan0/drop_unicast_in_l2_multicast: No such file or directory
Apr 15 12:15:01 primo wpa_supplicant[9219]: nl80211: Failed to set IPv4 unicast in multicast filter
Apr 15 12:15:01 primo wpa_supplicant[9219]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Apr 15 12:15:01 primo volumio[5490]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 15 12:15:01 primo wpa_supplicant[9219]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING
Apr 15 12:15:01 primo kernel: [35B blob data]
Apr 15 12:15:01 primo kernel: Exit. P2P interface stopped
Apr 15 12:15:01 primo kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Reason 3
Apr 15 12:15:01 primo kernel: dhd_dbg_stop_pkt_monitor, 1963
Apr 15 12:15:01 primo kernel: wl_iw_event: Link Down with b0:f2:08:ac:4d:09, reason=2
Apr 15 12:15:01 primo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK
Apr 15 12:15:01 primo kernel: link down if wlan0 may call cfg80211_disconnected. event : 16, reason=2 from b0:f2:08:ac:4d:09
Apr 15 12:15:01 primo kernel: dhd_dbg_stop_pkt_monitor, 1963
Apr 15 12:15:01 primo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1
Apr 15 12:15:01 primo wpa_supplicant[9219]: wlan0: CTRL-EVENT-DISCONNECTED bssid=b0:f2:08:ac:4d:09 reason=3 locally_generated=1
Apr 15 12:15:01 primo dhcpcd[5833]: wlan0: carrier lost
Apr 15 12:15:01 primo wpa_supplicant[9219]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Apr 15 12:15:01 primo avahi-daemon[4532]: Withdrawing address record for 192.168.178.36 on wlan0.
Apr 15 12:15:01 primo avahi-daemon[4532]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.36.
Apr 15 12:15:01 primo avahi-daemon[4532]: Interface wlan0.IPv4 no longer relevant for mDNS.
Apr 15 12:15:01 primo volumio[5490]: info: Discovery: A device disappeared from network
Apr 15 12:15:01 primo volumio[5490]: info: Discovery: Device primo disappeared from network
Apr 15 12:15:01 primo kernel: dhd_stop: Enter ffffffc002835000
Apr 15 12:15:01 primo kernel: CFGP2P-ERROR) wl_cfgp2p_disable_discovery : do nothing, not initialized
Apr 15 12:15:01 primo kernel: CFG80211-ERROR) wl_cfgp2p_down : Clean up the p2p discovery IF
Apr 15 12:15:01 primo kernel: wl_cfgp2p_del_p2p_disc_if: wdev: ffffffc04de1dc00, wdev->net: (null)
Apr 15 12:15:01 primo dhcpcd[5833]: wlan0: deleting route to 192.168.178.0/24
Apr 15 12:15:01 primo kernel: P2P interface unregistered
Apr 15 12:15:01 primo kernel: CFGP2P-ERROR) wl_cfgp2p_deinit_priv : In
Apr 15 12:15:01 primo kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 1 -> mode 0
Apr 15 12:15:01 primo kernel: wl_android_wifi_off in 1
Apr 15 12:15:01 primo kernel: wl_android_wifi_off in 2: g_wifi_on=1, on_failure=1
Apr 15 12:15:01 primo kernel: dhd_dbg_detach_pkt_monitor, 2204
Apr 15 12:15:01 primo kernel: dhd_bus_devreset: == Power OFF ==
Apr 15 12:15:01 primo kernel: bcmsdh_oob_intr_unregister: Enter
Apr 15 12:15:01 primo kernel: dhd_txglom_enable: enable 0
Apr 15 12:15:01 primo kernel: dhd_conf_set_txglom_params: txglom_mode=copy
Apr 15 12:15:01 primo kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0
Apr 15 12:15:01 primo kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1
Apr 15 12:15:01 primo kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300
Apr 15 12:15:01 primo kernel: dhd_bus_devreset: WLAN OFF DONE
Apr 15 12:15:01 primo kernel: wifi_platform_set_power = 0
Apr 15 12:15:01 primo kernel: ======== PULL WL_REG_ON(-1) LOW! ========
Apr 15 12:15:01 primo kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482
Apr 15 12:15:02 primo kernel: wl_android_wifi_off out
Apr 15 12:15:02 primo kernel: wl_ext_iapsta_dettach_netdev: Enter
Apr 15 12:15:02 primo kernel: dhd_stop: Exit
Apr 15 12:15:02 primo dhcpcd[5833]: wlan0: deleting default route via 192.168.178.1
Apr 15 12:15:02 primo wpa_supplicant[9219]: wlan0: CTRL-EVENT-TERMINATING
Apr 15 12:15:02 primo systemd[1]: wireless.service: Succeeded.
Apr 15 12:15:02 primo systemd[1]: Stopped Wireless Services.
Apr 15 12:15:02 primo volumio[5490]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 15 12:15:02 primo systemd[1]: Starting Wireless Services...
Apr 15 12:15:02 primo volumio[5490]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 15 12:15:02 primo dhcpcd[5833]: wlan0: carrier acquired
Apr 15 12:15:02 primo dhcpcd[5833]: wlan0: IAID 0e:ab:bf:fe
Apr 15 12:15:02 primo dhcpcd[5833]: wlan0: carrier lost
Apr 15 12:15:02 primo volumio[5490]: info: Discovery: A device disappeared from network
Apr 15 12:15:02 primo wireless.js[10268]: Cleaning previous...
Apr 15 12:15:02 primo sudo[10334]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 15 12:15:02 primo sudo[10334]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:02 primo sudo[10334]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:02 primo sudo[10337]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 15 12:15:02 primo sudo[10337]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:02 primo sudo[10337]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:03 primo wireless.js[10268]: Stopped aP
Apr 15 12:15:03 primo sudo[10345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 15 12:15:03 primo sudo[10345]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:03 primo kernel: dhd_open: Enter ffffffc002835000
Apr 15 12:15:03 primo kernel: dhd_open : no mutex held. set lock
Apr 15 12:15:03 primo kernel:
Dongle Host Driver, version 1.579.77.41.10 (r)
Apr 15 12:15:03 primo kernel: wl_ext_iapsta_attach_netdev: ifidx=0, bssidx=0
Apr 15 12:15:03 primo kernel: wl_android_wifi_on in 1
Apr 15 12:15:03 primo kernel: wl_android_wifi_on in 2: g_wifi_on=0
Apr 15 12:15:03 primo kernel: wifi_platform_set_power = 1
Apr 15 12:15:03 primo kernel: ======== PULL WL_REG_ON(-1) HIGH! ========
Apr 15 12:15:03 primo kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482
Apr 15 12:15:03 primo kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Enable! 482
Apr 15 12:15:03 primo kernel: sdio_reset_comm():
Apr 15 12:15:03 primo kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80
Apr 15 12:15:03 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Apr 15 12:15:03 primo kernel: meson-mmc: actual_clock :0, HHI_nand: 0x80
Apr 15 12:15:03 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Apr 15 12:15:03 primo kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80
Apr 15 12:15:03 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Apr 15 12:15:03 primo kernel: sdio_read_cis: 2 callbacks suppressed
Apr 15 12:15:03 primo kernel: sdio: queuing unknown CIS tuple 0x80 (2 bytes)
Apr 15 12:15:03 primo kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes)
Apr 15 12:15:03 primo kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes)
Apr 15 12:15:03 primo kernel: sdio: queuing unknown CIS tuple 0x80 (7 bytes)
Apr 15 12:15:03 primo kernel: sdio: queuing unknown CIS tuple 0x81 (9 bytes)
Apr 15 12:15:03 primo kernel: sdio: queuing unknown CIS tuple 0x8e (9 bytes)
Apr 15 12:15:04 primo kernel: meson-aml-mmc ffe03000.sdio: divider requested rate 200000000 != actual rate 199999997: ret=0
Apr 15 12:15:04 primo kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80
Apr 15 12:15:04 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245
Apr 15 12:15:04 primo kernel: meson-mmc: Data 1 aligned delay is 0
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: clk 199999997 tuning start
Apr 15 12:15:04 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: [prev_map] fixed_adj_win_map:30
Apr 15 12:15:04 primo kernel: meson-mmc: [0]=0
Apr 15 12:15:04 primo kernel: meson-mmc: [1]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [2]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [3]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [4]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:04 primo kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104
Apr 15 12:15:04 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:04 primo kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208
Apr 15 12:15:04 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:04 primo kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:04 primo kernel: meson-mmc: step:16, delay1:0x10410410, delay2:0x10010410
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:04 primo kernel: meson-mmc: [>>>>>>>>bitmap_xor_dst] fixed_adj_win_map:2
Apr 15 12:15:04 primo kernel: meson-mmc: [0]=0
Apr 15 12:15:04 primo kernel: meson-mmc: [1]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [2]=0
Apr 15 12:15:04 primo kernel: meson-mmc: [3]=0
Apr 15 12:15:04 primo kernel: meson-mmc: [4]=0
Apr 15 12:15:04 primo kernel: meson-mmc: [_find_fixed_adj_valid_win] fir_adj:1
Apr 15 12:15:04 primo kernel: meson-mmc: [>>>>>>>>prev_map_range] fixed_adj_win_map:495
Apr 15 12:15:04 primo kernel: meson-mmc: [1]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [2]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [3]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [4]=1
Apr 15 12:15:04 primo kernel: meson-mmc: [0]=0
Apr 15 12:15:04 primo kernel: meson-mmc: left:3, right:0, mid:4, size:4
Apr 15 12:15:04 primo kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0
Apr 15 12:15:04 primo kernel: meson-mmc: sdio: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x32000
Apr 15 12:15:04 primo kernel: meson-mmc: delay1:0x0, delay2:0x0
Apr 15 12:15:04 primo kernel: sdioh_start: set sd_f2_blocksize 256
Apr 15 12:15:04 primo kernel:
dhd_bus_devreset: == WLAN ON ==
Apr 15 12:15:04 primo kernel: F1 signature read @0x18000000=0x17294359
Apr 15 12:15:04 primo kernel: F1 signature OK, socitype:0x1 chip:0x4359 rev:0x9 pkg:0x2
Apr 15 12:15:04 primo kernel: DHD: dongle ram size is set to 917504(orig 917504) at 0x160000
Apr 15 12:15:04 primo kernel: dhd_bus_set_default_min_res_mask: Unhandled chip id
Apr 15 12:15:04 primo kernel: dhd_os_open_image: /lib/firmware/brcm/config_bcm4359c0_ag.txt (185 bytes) open success
Apr 15 12:15:04 primo kernel: dhd_conf_read_sdio_params: dhd_slpauto = 0
Apr 15 12:15:04 primo kernel: dhd_conf_read_others: ccode = ALL
Apr 15 12:15:04 primo kernel: dhd_conf_read_others: regrev = 38
Apr 15 12:15:04 primo kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=5
Apr 15 12:15:04 primo kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt
Apr 15 12:15:04 primo kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt
Apr 15 12:15:04 primo kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt
Apr 15 12:15:04 primo kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt
Apr 15 12:15:04 primo kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt
Apr 15 12:15:04 primo kernel: Final fw_path=/lib/firmware/brcm/fw_bcm4359c0_ag.bin
Apr 15 12:15:04 primo kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6359sa.txt
Apr 15 12:15:04 primo kernel: Final clm_path=/lib/firmware/brcm/clm.blob
Apr 15 12:15:04 primo kernel: Final conf_path=/lib/firmware/brcm/config_bcm4359c0_ag.txt
Apr 15 12:15:04 primo kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm4359c0_ag.bin (595758 bytes) open success
Apr 15 12:15:04 primo kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6359sa.txt (5861 bytes) open success
Apr 15 12:15:04 primo kernel: [43B blob data]
Apr 15 12:15:04 primo kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded.
Apr 15 12:15:04 primo kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us)
Apr 15 12:15:04 primo kernel: si_get_pmu_reg_addr: addrRET: 18000670
Apr 15 12:15:04 primo kernel: bcmsdh_oob_intr_register: HW_OOB irq=70 flags=0x8
Apr 15 12:15:04 primo kernel: dhd_get_memdump_info: File [/data/misc/wifi/.memdump.info] doesn't exist
Apr 15 12:15:04 primo kernel: dhd_get_memdump_info: MEMDUMP ENABLED = 2
Apr 15 12:15:04 primo kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 0 -> mode 1
Apr 15 12:15:04 primo kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm.blob
Apr 15 12:15:04 primo kernel: Firmware up: op_mode=0x0405, MAC=70:4a:0e:ab:bf:fe
Apr 15 12:15:04 primo kernel: Driver: 1.579.77.41.10 (r)
Firmware: wl0: Jan 19 2018 12:14:30 version 9.87.51.11.8 (a85e25e@shgit) (r) FWID 01-cb5aa0a5
CLM: 9.7.5
Apr 15 12:15:04 primo kernel: dhd_txglom_enable: enable 1
Apr 15 12:15:04 primo kernel: dhd_conf_set_txglom_params: txglom_mode=copy
Apr 15 12:15:04 primo kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0
Apr 15 12:15:04 primo kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1
Apr 15 12:15:04 primo kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300
Apr 15 12:15:04 primo kernel: dhd_conf_get_disable_proptx: fw_proptx=0, disable_proptx=1
Apr 15 12:15:04 primo kernel: dhd_pno_init: Support Android Location Service
Apr 15 12:15:04 primo kernel: rtt_do_get_ioctl: failed to send getbuf proxd iovar (CMD ID : 1), status=-23
Apr 15 12:15:04 primo kernel: dhd_rtt_init : FTM is not supported
Apr 15 12:15:04 primo kernel: dhd_preinit_ioctls: SensorHub diabled 0
Apr 15 12:15:04 primo kernel: dhd_preinit_ioctls failed to set ShubHub disable
Apr 15 12:15:04 primo kernel: failed to set WNM capabilities
Apr 15 12:15:04 primo kernel: dhd_conf_set_country: set country ALL, revision 38
Apr 15 12:15:04 primo kernel: CONFIG-ERROR) dhd_conf_set_bufiovar: country setting failed -2
Apr 15 12:15:04 primo kernel: Country code: US (US/0)
Apr 15 12:15:04 primo kernel: CONFIG-ERROR) dhd_conf_set_intiovar: txbf setting failed -23
Apr 15 12:15:04 primo kernel: wl_android_wifi_on: Success
Apr 15 12:15:04 primo kernel: dhd_open : the lock is released.
Apr 15 12:15:04 primo kernel: dhd_open: Exit ret=0
Apr 15 12:15:04 primo dhcpcd[5833]: wlan0: carrier acquired
Apr 15 12:15:04 primo ntpd[9320]: Deleting interface #4 wlan0, 192.168.178.36#123, interface stats: received=0, sent=0, dropped=0, active_time=638 secs
Apr 15 12:15:04 primo sudo[10345]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:04 primo dhcpcd[5833]: wlan0: IAID 0e:ab:bf:fe
Apr 15 12:15:04 primo sudo[10350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Apr 15 12:15:04 primo sudo[10350]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:04 primo sudo[10350]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:04 primo sudo[10357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 15 12:15:04 primo sudo[10357]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:04 primo sudo[10357]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:04 primo sudo[10360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Apr 15 12:15:04 primo sudo[10360]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:04 primo dhcpcd[5833]: wlan0: soliciting an IPv6 router
Apr 15 12:15:04 primo dhcpcd[5833]: wlan0: rebinding lease of 192.168.178.36
Apr 15 12:15:06 primo volumio[5490]: info: Discovery: Started advertising with name: Primo
Apr 15 12:15:06 primo sudo[10360]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:06 primo wireless.js[10268]: Start wireless flow
Apr 15 12:15:06 primo wireless.js[10268]: Stopped hotspot (if there)..
Apr 15 12:15:06 primo sudo[10371]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 15 12:15:06 primo sudo[10371]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:06 primo sudo[10371]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:06 primo sudo[10374]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 15 12:15:06 primo sudo[10374]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:06 primo kernel: dhd_stop: Enter ffffffc002835000
Apr 15 12:15:06 primo kernel: CFGP2P-ERROR) wl_cfgp2p_disable_discovery : do nothing, not initialized
Apr 15 12:15:06 primo kernel: CFGP2P-ERROR) wl_cfgp2p_deinit_priv : In
Apr 15 12:15:06 primo kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 1 -> mode 0
Apr 15 12:15:06 primo kernel: wl_android_wifi_off in 1
Apr 15 12:15:06 primo kernel: wl_android_wifi_off in 2: g_wifi_on=1, on_failure=1
Apr 15 12:15:06 primo kernel: dhd_dbg_detach_pkt_monitor, 2204
Apr 15 12:15:06 primo kernel: dhd_bus_devreset: == Power OFF ==
Apr 15 12:15:06 primo kernel: bcmsdh_oob_intr_unregister: Enter
Apr 15 12:15:06 primo kernel: dhd_txglom_enable: enable 0
Apr 15 12:15:06 primo kernel: dhd_conf_set_txglom_params: txglom_mode=copy
Apr 15 12:15:06 primo kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0
Apr 15 12:15:06 primo kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1
Apr 15 12:15:06 primo kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300
Apr 15 12:15:06 primo kernel: dhd_bus_devreset: WLAN OFF DONE
Apr 15 12:15:06 primo kernel: wifi_platform_set_power = 0
Apr 15 12:15:06 primo kernel: ======== PULL WL_REG_ON(-1) LOW! ========
Apr 15 12:15:06 primo kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482
Apr 15 12:15:07 primo dhcpcd[5833]: wlan0: carrier lost
Apr 15 12:15:07 primo kernel: wl_android_wifi_off out
Apr 15 12:15:07 primo kernel: wl_ext_iapsta_dettach_netdev: Enter
Apr 15 12:15:07 primo kernel: dhd_stop: Exit
Apr 15 12:15:07 primo sudo[10374]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:07 primo wireless.js[10268]: DHCP IP
Apr 15 12:15:07 primo wireless.js[10268]: Start ap
Apr 15 12:15:07 primo wpa_supplicant[10383]: Successfully initialized wpa_supplicant
Apr 15 12:15:07 primo kernel: dhd_open: Enter ffffffc002835000
Apr 15 12:15:07 primo kernel: dhd_open : no mutex held. set lock
Apr 15 12:15:07 primo kernel:
Dongle Host Driver, version 1.579.77.41.10 (r)
Apr 15 12:15:07 primo kernel: wl_ext_iapsta_attach_netdev: ifidx=0, bssidx=0
Apr 15 12:15:07 primo kernel: wl_android_wifi_on in 1
Apr 15 12:15:07 primo kernel: wl_android_wifi_on in 2: g_wifi_on=0
Apr 15 12:15:07 primo kernel: wifi_platform_set_power = 1
Apr 15 12:15:07 primo kernel: ======== PULL WL_REG_ON(-1) HIGH! ========
Apr 15 12:15:07 primo kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482
Apr 15 12:15:07 primo kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Enable! 482
Apr 15 12:15:07 primo volumio[5490]: info: Discovery: adding undefined
Apr 15 12:15:07 primo volumio[5490]: info: Discovery: Found device Primo
Apr 15 12:15:07 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:15:07 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:07 primo kernel: sdio_reset_comm():
Apr 15 12:15:07 primo kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80
Apr 15 12:15:07 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Apr 15 12:15:07 primo kernel: meson-mmc: actual_clock :0, HHI_nand: 0x80
Apr 15 12:15:07 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Apr 15 12:15:07 primo kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80
Apr 15 12:15:07 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Apr 15 12:15:07 primo kernel: sdio: queuing unknown CIS tuple 0x80 (2 bytes)
Apr 15 12:15:07 primo kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes)
Apr 15 12:15:07 primo kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes)
Apr 15 12:15:07 primo kernel: sdio: queuing unknown CIS tuple 0x80 (7 bytes)
Apr 15 12:15:08 primo kernel: meson-aml-mmc ffe03000.sdio: divider requested rate 200000000 != actual rate 199999997: ret=0
Apr 15 12:15:08 primo kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80
Apr 15 12:15:08 primo kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245
Apr 15 12:15:08 primo kernel: meson-mmc: Data 1 aligned delay is 0
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: clk 199999997 tuning start
Apr 15 12:15:08 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: [prev_map] fixed_adj_win_map:30
Apr 15 12:15:08 primo kernel: meson-mmc: [0]=0
Apr 15 12:15:08 primo kernel: meson-mmc: [1]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [2]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [3]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [4]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:08 primo kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104
Apr 15 12:15:08 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:08 primo kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208
Apr 15 12:15:08 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:08 primo kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj...
Apr 15 12:15:08 primo kernel: meson-mmc: step:16, delay1:0x10410410, delay2:0x10010410
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Apr 15 12:15:08 primo kernel: meson-mmc: [>>>>>>>>bitmap_xor_dst] fixed_adj_win_map:2
Apr 15 12:15:08 primo kernel: meson-mmc: [0]=0
Apr 15 12:15:08 primo kernel: meson-mmc: [1]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [2]=0
Apr 15 12:15:08 primo kernel: meson-mmc: [3]=0
Apr 15 12:15:08 primo kernel: meson-mmc: [4]=0
Apr 15 12:15:08 primo kernel: meson-mmc: [_find_fixed_adj_valid_win] fir_adj:1
Apr 15 12:15:08 primo kernel: meson-mmc: [>>>>>>>>prev_map_range] fixed_adj_win_map:495
Apr 15 12:15:08 primo kernel: meson-mmc: [1]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [2]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [3]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [4]=1
Apr 15 12:15:08 primo kernel: meson-mmc: [0]=0
Apr 15 12:15:08 primo kernel: meson-mmc: left:3, right:0, mid:4, size:4
Apr 15 12:15:08 primo kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0
Apr 15 12:15:08 primo kernel: meson-mmc: sdio: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x32000
Apr 15 12:15:08 primo kernel: meson-mmc: delay1:0x0, delay2:0x0
Apr 15 12:15:08 primo kernel: sdioh_start: set sd_f2_blocksize 256
Apr 15 12:15:08 primo kernel:
dhd_bus_devreset: == WLAN ON ==
Apr 15 12:15:08 primo kernel: F1 signature read @0x18000000=0x17294359
Apr 15 12:15:08 primo kernel: F1 signature OK, socitype:0x1 chip:0x4359 rev:0x9 pkg:0x2
Apr 15 12:15:08 primo kernel: DHD: dongle ram size is set to 917504(orig 917504) at 0x160000
Apr 15 12:15:08 primo kernel: dhd_bus_set_default_min_res_mask: Unhandled chip id
Apr 15 12:15:08 primo kernel: dhd_os_open_image: /lib/firmware/brcm/config_bcm4359c0_ag.txt (185 bytes) open success
Apr 15 12:15:08 primo kernel: dhd_conf_read_sdio_params: dhd_slpauto = 0
Apr 15 12:15:08 primo kernel: dhd_conf_read_others: ccode = ALL
Apr 15 12:15:08 primo kernel: dhd_conf_read_others: regrev = 38
Apr 15 12:15:08 primo kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=5
Apr 15 12:15:08 primo kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt
Apr 15 12:15:08 primo kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt
Apr 15 12:15:08 primo kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt
Apr 15 12:15:08 primo kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt
Apr 15 12:15:08 primo kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt
Apr 15 12:15:08 primo kernel: Final fw_path=/lib/firmware/brcm/fw_bcm4359c0_ag.bin
Apr 15 12:15:08 primo kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6359sa.txt
Apr 15 12:15:08 primo kernel: Final clm_path=/lib/firmware/brcm/clm.blob
Apr 15 12:15:08 primo kernel: Final conf_path=/lib/firmware/brcm/config_bcm4359c0_ag.txt
Apr 15 12:15:08 primo kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm4359c0_ag.bin (595758 bytes) open success
Apr 15 12:15:08 primo wireless.js[10268]: trying...
Apr 15 12:15:08 primo kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6359sa.txt (5861 bytes) open success
Apr 15 12:15:08 primo kernel: [43B blob data]
Apr 15 12:15:08 primo kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded.
Apr 15 12:15:08 primo kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us)
Apr 15 12:15:08 primo kernel: si_get_pmu_reg_addr: addrRET: 18000670
Apr 15 12:15:08 primo kernel: bcmsdh_oob_intr_register: HW_OOB irq=70 flags=0x8
Apr 15 12:15:08 primo kernel: dhd_get_memdump_info: File [/data/misc/wifi/.memdump.info] doesn't exist
Apr 15 12:15:08 primo kernel: dhd_get_memdump_info: MEMDUMP ENABLED = 2
Apr 15 12:15:08 primo kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 0 -> mode 1
Apr 15 12:15:08 primo kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm.blob
Apr 15 12:15:08 primo kernel: Firmware up: op_mode=0x0405, MAC=70:4a:0e:ab:bf:fe
Apr 15 12:15:08 primo kernel: Driver: 1.579.77.41.10 (r)
Firmware: wl0: Jan 19 2018 12:14:30 version 9.87.51.11.8 (a85e25e@shgit) (r) FWID 01-cb5aa0a5
CLM: 9.7.5
Apr 15 12:15:08 primo kernel: dhd_txglom_enable: enable 1
Apr 15 12:15:08 primo kernel: dhd_conf_set_txglom_params: txglom_mode=copy
Apr 15 12:15:08 primo kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0
Apr 15 12:15:08 primo kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1
Apr 15 12:15:08 primo kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300
Apr 15 12:15:08 primo kernel: dhd_conf_get_disable_proptx: fw_proptx=0, disable_proptx=1
Apr 15 12:15:08 primo kernel: dhd_pno_init: Support Android Location Service
Apr 15 12:15:08 primo kernel: rtt_do_get_ioctl: failed to send getbuf proxd iovar (CMD ID : 1), status=-23
Apr 15 12:15:08 primo kernel: dhd_rtt_init : FTM is not supported
Apr 15 12:15:08 primo kernel: dhd_preinit_ioctls: SensorHub diabled 0
Apr 15 12:15:08 primo kernel: dhd_preinit_ioctls failed to set ShubHub disable
Apr 15 12:15:08 primo kernel: failed to set WNM capabilities
Apr 15 12:15:08 primo kernel: dhd_conf_set_country: set country ALL, revision 38
Apr 15 12:15:08 primo kernel: CONFIG-ERROR) dhd_conf_set_bufiovar: country setting failed -2
Apr 15 12:15:08 primo kernel: Country code: US (US/0)
Apr 15 12:15:08 primo kernel: CONFIG-ERROR) dhd_conf_set_intiovar: txbf setting failed -23
Apr 15 12:15:08 primo kernel: wl_android_wifi_on: Success
Apr 15 12:15:08 primo kernel: dhd_open : the lock is released.
Apr 15 12:15:08 primo kernel: dhd_open: Exit ret=0
Apr 15 12:15:08 primo dhcpcd[5833]: wlan0: carrier acquired
Apr 15 12:15:08 primo sudo[10387]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Apr 15 12:15:08 primo dhcpcd[5833]: wlan0: IAID 0e:ab:bf:fe
Apr 15 12:15:08 primo dhcpcd[5833]: wlan0: carrier lost
Apr 15 12:15:08 primo sudo[10387]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:08 primo sudo[10413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:08 primo sudo[10413]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:08 primo dhcpcd[10418]: sending commands to master dhcpcd process
Apr 15 12:15:08 primo sudo[10413]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:08 primo sudo[10387]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:08 primo kernel: P2P interface registered
Apr 15 12:15:08 primo kernel: wl_cfgp2p_add_p2p_disc_if: wdev: ffffffc03f821000, wdev->net: (null)
Apr 15 12:15:08 primo dhcpcd[5833]: control command: /sbin/dhcpcd
Apr 15 12:15:08 primo kernel: [35B blob data]
Apr 15 12:15:08 primo kernel: P2P interface started
Apr 15 12:15:08 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:09 primo wireless.js[10268]: trying...
Apr 15 12:15:09 primo sudo[10439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:09 primo sudo[10439]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:09 primo sudo[10439]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:10 primo wireless.js[10268]: trying...
Apr 15 12:15:10 primo sudo[10442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:10 primo sudo[10442]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:10 primo sudo[10442]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:10 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:15:10 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:10 primo wpa_supplicant[10437]: wlan0: Trying to associate with b0:f2:08:ac:4d:09 (SSID='sigaletho1' freq=5580 MHz)
Apr 15 12:15:10 primo kernel: Connecting with b0:f2:08:ac:4d:09 ssid "sigaletho1", len (10) channel=116
Apr 15 12:15:10 primo kernel: dhd_dbg_start_pkt_monitor, 1724
Apr 15 12:15:10 primo kernel: wl_iw_event: Link UP with b0:f2:08:ac:4d:09
Apr 15 12:15:10 primo kernel: wl_bss_connect_done succeeded with b0:f2:08:ac:4d:09
Apr 15 12:15:10 primo kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed
Apr 15 12:15:10 primo wpa_supplicant[10437]: wlan0: Associated with b0:f2:08:ac:4d:09
Apr 15 12:15:10 primo wpa_supplicant[10437]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 15 12:15:10 primo wpa_supplicant[10437]: wlan0: WPA: Key negotiation completed with b0:f2:08:ac:4d:09 [PTK=CCMP GTK=CCMP]
Apr 15 12:15:10 primo wpa_supplicant[10437]: wlan0: CTRL-EVENT-CONNECTED - Connection to b0:f2:08:ac:4d:09 completed [id=0 id_str=]
Apr 15 12:15:10 primo dhcpcd[5833]: wlan0: carrier acquired
Apr 15 12:15:10 primo wpa_supplicant[10437]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE
Apr 15 12:15:10 primo dhcpcd[5833]: wlan0: IAID 0e:ab:bf:fe
Apr 15 12:15:10 primo kernel: wl_bss_connect_done succeeded with b0:f2:08:ac:4d:09 vndr_oui: 8C-FD-F0
Apr 15 12:15:11 primo wireless.js[10268]: trying...
Apr 15 12:15:11 primo sudo[10448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:11 primo sudo[10448]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:11 primo sudo[10448]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:11 primo dhcpcd[5833]: wlan0: soliciting an IPv6 router
Apr 15 12:15:11 primo dhcpcd[5833]: wlan0: rebinding lease of 192.168.178.36
Apr 15 12:15:11 primo dhcpcd[5833]: wlan0: probing address 192.168.178.36/24
Apr 15 12:15:12 primo wireless.js[10268]: trying...
Apr 15 12:15:12 primo sudo[10451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:12 primo sudo[10451]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:12 primo sudo[10451]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:13 primo wireless.js[10268]: trying...
Apr 15 12:15:13 primo sudo[10454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:13 primo sudo[10454]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:13 primo sudo[10454]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 15 12:15:13 primo volumio[5490]: info: Retrieving Cloud Streaming UI
Apr 15 12:15:13 primo volumio[5490]: info: Getting Tidal Cloud Configuration
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 15 12:15:13 primo volumio[5490]: info: Getting Qobuz Cloud Configuration
Apr 15 12:15:13 primo volumio[5490]: info: Asking plugin for UI Config
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 15 12:15:13 primo volumio[5490]: info: Getting Spotify Cloud Configuration
Apr 15 12:15:13 primo volumio[5490]: info: Asking plugin for UI Config
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 15 12:15:13 primo volumio[5490]: info: Saving Spotify Acccount
Apr 15 12:15:13 primo volumio[5490]: info: Got it
Apr 15 12:15:13 primo volumio[5490]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 15 12:15:13 primo volumio[5490]: info: Got Tidal Cloud Configuration
Apr 15 12:15:13 primo volumio[5490]: info: Got it
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 15 12:15:13 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 15 12:15:14 primo wireless.js[10268]: trying...
Apr 15 12:15:14 primo sudo[10458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:14 primo sudo[10458]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:14 primo sudo[10458]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:15 primo wireless.js[10268]: trying...
Apr 15 12:15:15 primo sudo[10461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:15 primo sudo[10461]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:15 primo sudo[10461]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:16 primo wireless.js[10268]: trying...
Apr 15 12:15:16 primo sudo[10464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:16 primo sudo[10464]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:16 primo sudo[10464]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:16 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:16 primo dhcpcd[5833]: wlan0: leased 192.168.178.36 for 34560000 seconds
Apr 15 12:15:16 primo avahi-daemon[4532]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.36.
Apr 15 12:15:16 primo dhcpcd[5833]: wlan0: adding route to 192.168.178.0/24
Apr 15 12:15:16 primo dhcpcd[5833]: wlan0: adding default route via 192.168.178.1
Apr 15 12:15:16 primo avahi-daemon[4532]: New relevant interface wlan0.IPv4 for mDNS.
Apr 15 12:15:16 primo avahi-daemon[4532]: Registering new address record for 192.168.178.36 on wlan0.IPv4.
Apr 15 12:15:17 primo ntpd[9320]: ntpd exiting on signal 15 (Terminated)
Apr 15 12:15:17 primo ntpd[9320]: 185.252.140.125 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 176.9.157.155 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo systemd[1]: Stopping Network Time Service...
Apr 15 12:15:17 primo ntpd[9320]: 178.215.228.24 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 141.98.136.83 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 131.188.3.220 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 178.63.166.157 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 49.12.199.148 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 144.76.76.107 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 144.76.0.164 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 128.127.67.142 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 185.232.69.65 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 90.187.112.137 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 81.169.204.195 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo ntpd[9320]: 85.214.38.116 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo wireless.js[10268]: trying...
Apr 15 12:15:17 primo volumio[5490]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 15 12:15:17 primo ntpd[9320]: 49.12.125.53 local addr 192.168.178.30 ->
Apr 15 12:15:17 primo systemd[1]: ntp.service: Succeeded.
Apr 15 12:15:17 primo systemd[1]: Stopped Network Time Service.
Apr 15 12:15:17 primo volumio[5490]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 15 12:15:17 primo sudo[10499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 15 12:15:17 primo sudo[10499]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:17 primo systemd[1]: Starting Network Time Service...
Apr 15 12:15:17 primo volumio[5490]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 15 12:15:17 primo sudo[10499]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:17 primo wireless.js[10268]: Connected to: ----sigaletho1
Apr 15 12:15:17 primo wireless.js[10268]: ----
Apr 15 12:15:17 primo sudo[10533]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 15 12:15:17 primo sudo[10533]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:17 primo sudo[10533]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:17 primo ntpd[10502]: ntpd 4.2.8p12@1.3728-o (1): Starting
Apr 15 12:15:17 primo ntpd[10502]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Apr 15 12:15:17 primo systemd[1]: Started Network Time Service.
Apr 15 12:15:17 primo wireless.js[10268]: ... joined AP, wlan0 IPv4 is 192.168.178.36, ipV6 is undefined
Apr 15 12:15:17 primo wireless.js[10268]: It's done! AP
Apr 15 12:15:17 primo ntpd[10541]: proto: precision = 1.250 usec (-20)
Apr 15 12:15:17 primo ntpd[10541]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Apr 15 12:15:17 primo ntpd[10541]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Apr 15 12:15:17 primo ntpd[10541]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 475 days ago
Apr 15 12:15:17 primo ntpd[10541]: Listen and drop on 0 v6wildcard [::]:123
Apr 15 12:15:17 primo ntpd[10541]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr 15 12:15:17 primo ntpd[10541]: Listen normally on 2 lo 127.0.0.1:123
Apr 15 12:15:17 primo ntpd[10541]: Listen normally on 3 eth0 192.168.178.30:123
Apr 15 12:15:17 primo ntpd[10541]: Listen normally on 4 wlan0 192.168.178.36:123
Apr 15 12:15:17 primo ntpd[10541]: Listening on routing socket on fd #21 for interface updates
Apr 15 12:15:17 primo ntpd[10541]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Apr 15 12:15:17 primo ntpd[10541]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized
Apr 15 12:15:17 primo systemd[1]: Started Wireless Services.
Apr 15 12:15:17 primo sudo[10231]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:17 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 15 12:15:17 primo volumio[5490]: info: Discovery: this is already registered, undefined
Apr 15 12:15:17 primo volumio[5490]: info: Discovery: Found device Primo
Apr 15 12:15:17 primo volumio[5490]: info: CoreCommandRouter::volumioGetState
Apr 15 12:15:17 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:18 primo ntpd[10541]: Soliciting pool server 168.119.238.107
Apr 15 12:15:19 primo ntpd[10541]: Soliciting pool server 144.91.116.85
Apr 15 12:15:19 primo ntpd[10541]: Soliciting pool server 129.250.35.251
Apr 15 12:15:20 primo ntpd[10541]: Soliciting pool server 176.9.44.212
Apr 15 12:15:20 primo ntpd[10541]: Soliciting pool server 79.133.44.138
Apr 15 12:15:20 primo ntpd[10541]: Soliciting pool server 144.76.66.156
Apr 15 12:15:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 15 12:15:20 primo volumio[5490]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 15 12:15:20 primo volumio[5490]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 12:15:20 primo volumio[5490]: info:
Apr 15 12:15:20 primo volumio[5490]: ---------------------------- MPD announces state update: update
Apr 15 12:15:20 primo volumio[5490]: info: sendMpdCommand rescan took 28 milliseconds
Apr 15 12:15:20 primo volumio[5490]: info: ControllerMpd::getState
Apr 15 12:15:20 primo volumio[5490]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 12:15:20 primo volumio[5490]: info: sendMpdCommand status took 34 milliseconds
Apr 15 12:15:20 primo volumio[5490]: verbose: ControllerMpd::parseState
Apr 15 12:15:20 primo volumio[5490]: info: Command Router : Notfying DB Updatetrue
Apr 15 12:15:20 primo volumio[5490]: info: sendMpdCommand status took 101 milliseconds
Apr 15 12:15:20 primo volumio[5490]: verbose: ControllerMpd::parseState
Apr 15 12:15:20 primo volumio[5490]: info: ControllerMpd::pushState
Apr 15 12:15:20 primo volumio[5490]: info: CoreCommandRouter::servicePushState
Apr 15 12:15:20 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:20 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:20 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:20 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:20 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:20 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:20 primo volumio[5490]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Apr 15 12:15:20 primo volumio[5490]: verbose: CURRENT POSITION 0
Apr 15 12:15:20 primo volumio[5490]: info: CoreStateMachine::syncState stateService stop
Apr 15 12:15:20 primo volumio[5490]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 12:15:20 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:20 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:20 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 12:15:20 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:20 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:20 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:20 primo volumio[5490]: info: No code
Apr 15 12:15:20 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:20 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:20 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:20 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:20 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:20 primo volumio[5490]: info: ------------------------------ 166ms
Apr 15 12:15:20 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:20 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:20 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.030505, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Apr 15 12:15:21 primo nmbd[5191]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.030785, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 15 12:15:21 primo nmbd[5191]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.030930, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Apr 15 12:15:21 primo nmbd[5191]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.031050, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 15 12:15:21 primo nmbd[5191]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.031175, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Apr 15 12:15:21 primo nmbd[5191]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.031312, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 15 12:15:21 primo nmbd[5191]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.031437, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Apr 15 12:15:21 primo nmbd[5191]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.031557, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 15 12:15:21 primo nmbd[5191]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.031688, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Apr 15 12:15:21 primo nmbd[5191]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 15 12:15:21 primo nmbd[5191]: [2024/04/15 12:15:21.031828, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 15 12:15:21 primo nmbd[5191]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 15 12:15:21 primo ntpd[10541]: Soliciting pool server 178.63.9.212
Apr 15 12:15:21 primo ntpd[10541]: Soliciting pool server 178.215.228.24
Apr 15 12:15:21 primo ntpd[10541]: Soliciting pool server 51.75.67.47
Apr 15 12:15:21 primo ntpd[10541]: Soliciting pool server 128.140.109.119
Apr 15 12:15:21 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 15 12:15:22 primo volumio[5490]: info: CoreCommandRouter::Close All Modals sent
Apr 15 12:15:22 primo ntpd[10541]: Soliciting pool server 90.187.112.137
Apr 15 12:15:22 primo ntpd[10541]: Soliciting pool server 167.235.246.170
Apr 15 12:15:22 primo ntpd[10541]: Soliciting pool server 78.46.204.247
Apr 15 12:15:22 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection
Apr 15 12:15:22 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo
Apr 15 12:15:22 primo sudo[10562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 15 12:15:22 primo sudo[10562]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:22 primo sudo[10562]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:22 primo sudo[10566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 15 12:15:22 primo sudo[10566]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:22 primo sudo[10566]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:23 primo ntpd[10541]: Soliciting pool server 85.220.190.246
Apr 15 12:15:23 primo ntpd[10541]: Soliciting pool server 78.47.249.55
Apr 15 12:15:23 primo volumio[5490]: info: MPD Database updated - AlbumList cache refreshed
Apr 15 12:15:23 primo volumio[5490]: info:
Apr 15 12:15:23 primo volumio[5490]: ---------------------------- MPD announces state update: database
Apr 15 12:15:23 primo volumio[5490]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 12:15:23 primo volumio[5490]: info:
Apr 15 12:15:23 primo volumio[5490]: ---------------------------- MPD announces state update: update
Apr 15 12:15:23 primo volumio[5490]: info: ControllerMpd::getState
Apr 15 12:15:23 primo volumio[5490]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 12:15:23 primo volumio[5490]: info: ControllerMpd::getState
Apr 15 12:15:23 primo volumio[5490]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 12:15:23 primo volumio[5490]: info: sendMpdCommand status took 18 milliseconds
Apr 15 12:15:23 primo volumio[5490]: info: sendMpdCommand status took 17 milliseconds
Apr 15 12:15:23 primo volumio[5490]: info: sendMpdCommand status took 16 milliseconds
Apr 15 12:15:23 primo volumio[5490]: verbose: ControllerMpd::parseState
Apr 15 12:15:23 primo volumio[5490]: info: Command Router : Notfying DB Updatefalse
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::Close All Modals sent
Apr 15 12:15:23 primo volumio[5490]: verbose: ControllerMpd::parseState
Apr 15 12:15:23 primo volumio[5490]: verbose: ControllerMpd::parseState
Apr 15 12:15:23 primo volumio[5490]: info: ControllerMpd::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::servicePushState
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Apr 15 12:15:23 primo volumio[5490]: verbose: CURRENT POSITION 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::syncState stateService stop
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:23 primo volumio[5490]: info: No code
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:23 primo volumio[5490]: info: ControllerMpd::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::servicePushState
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Apr 15 12:15:23 primo volumio[5490]: verbose: CURRENT POSITION 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::syncState stateService stop
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:23 primo volumio[5490]: info: No code
Apr 15 12:15:23 primo volumio[5490]: info: CoreStateMachine::pushState
Apr 15 12:15:23 primo volumio[5490]: info: CorePlayQueue::getTrack 0
Apr 15 12:15:23 primo volumio[5490]: info: CoreCommandRouter::volumioPushState
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output update for this device
Apr 15 12:15:23 primo volumio[5490]: info: MRS: Pushing multiroomSync output
Apr 15 12:15:23 primo volumio[5490]: info: ------------------------------ 153ms
Apr 15 12:15:23 primo volumio[5490]: info: ------------------------------ 154ms
Apr 15 12:15:23 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:23 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:23 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:23 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:23 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:23 primo volumio[5490]: info: Updating RAAT Signal Path
Apr 15 12:15:24 primo nmbd[5191]: [2024/04/15 12:15:24.036026, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Apr 15 12:15:24 primo nmbd[5191]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable
Apr 15 12:15:24 primo ntpd[10541]: Soliciting pool server 2a02:a60:0:122:5652::16
Apr 15 12:15:24 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:25 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 15 12:15:27 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Apr 15 12:15:27 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart
Apr 15 12:15:27 primo volumio[5490]: info: Refreshing Cached IP Addresses
Apr 15 12:15:27 primo sudo[10576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Apr 15 12:15:27 primo sudo[10576]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:27 primo sudo[10577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 15 12:15:27 primo sudo[10577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:27 primo sudo[10576]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:27 primo sudo[10577]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:27 primo volumio[5490]: error: Upnp client error: Error: This socket has been ended by the other party
Apr 15 12:15:27 primo sudo[10582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 15 12:15:27 primo sudo[10582]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 15 12:15:27 primo sudo[10582]: pam_unix(sudo:session): session closed for user root
Apr 15 12:15:28 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Apr 15 12:15:28 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Apr 15 12:15:28 primo nmbd[5191]: [2024/04/15 12:15:28.328504, 0] ../source3/libsmb/nmblib.c:917(send_udp)
Apr 15 12:15:28 primo nmbd[5191]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable
Apr 15 12:15:29 primo volumio[5490]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 15 12:15:32 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:32 primo volumio[5490]: info: Discovery: Remote connection error: 192.168.178.51
Apr 15 12:15:33 primo volumio[5490]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 15 12:15:33 primo volumio[5490]: Error: dns service error: unknown
Apr 15 12:15:33 primo volumio[5490]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30)
Apr 15 12:15:33 primo volumio[5490]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Apr 15 12:15:33 primo volumio[5490]: errorCode: -65537
Apr 15 12:15:33 primo volumio[5490]: }
Apr 15 12:15:33 primo volumio[5490]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 15 12:15:33 primo sudo[10598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-15 12:14
Apr 15 12:15:33 primo sudo[10598]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="primo2rev2"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 12:01:04 PM CET"
VOLUMIO_VERSION="3.629"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Primo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Primo"
VOLUMIO_HASH="728189e850980f21ef569472434ec23d"