Kedge2: 5 GHz WiFI Connectivity Issues

Which system do you use? Android, Ubuntu, OOWOW or others?

Android 12

Which version of system do you use? Khadas official images, self-built images, or others?

Self built image from Khadas official source and @goenjoy's guidance.

Please describe your issue below:

Intermittent Wifi 5 GHz Association errors and “freezing” com.rockchip.devicetest & android.rockchip.update.service caused problems…

?? com.rockchip.devicetest ??
?? android.rockchip.update.service ??

What are they and why are they causing so many errors?

Post a console log of your issue below:

WiFi 5GHz would NOT ASSOCIATE during this logcat trace, specifically while android.rockchip.update.service and com.rockchip.devicetest cause errors. Note the Target SDK mismatch message. What is that?

$ logcat -d | grep -i rockchip
08-30 00:15:25.676   424   424 I [WLAN_RFKILL]: rockchip_wifi_power: 1
08-30 00:15:25.676   424   424 I [WLAN_RFKILL]: rockchip_wifi_power: toggle = false
08-30 00:15:22.428   590   590 V StorageManagerService: Package com.rockchip.overlay.pinnerservice does not have legacy storage
08-30 00:15:22.428   590   590 V StorageManagerService: Package android.rockchip.update.service does not have legacy storage
08-30 00:15:22.428   590   590 V StorageManagerService: Package com.rockchip.devicetest does not have legacy storage
08-30 00:15:35.950   590   618 I ActivityManager: Start proc 1499:com.rockchip.devicetest/1000 for broadcast {com.rockchip.devicetest/com.rockchip.devicetest.BootReceiver}
08-30 00:15:35.988  1499  1499 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1825 android.content.ContextWrapper.startService:776 android.content.ContextWrapper.startService:776 com.rockchip.devicetest.BootReceiver.onReceive:41 android.app.ActivityThread.handleReceiver:4375
08-30 00:15:36.006   590   618 I ActivityManager: Start proc 1535:android.rockchip.update.service/1000 for broadcast {android.rockchip.update.service/android.rockchip.update.service.RKUpdateReceiver}
08-30 00:15:36.049  1535  1535 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1825 android.content.ContextWrapper.startService:776 android.content.ContextWrapper.startService:776 android.rockchip.update.service.RKUpdateReceiver.onReceive:59 android.app.ActivityThread.handleReceiver:4375
08-30 00:15:36.050  1535  1535 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1825 android.content.ContextWrapper.startService:776 android.content.ContextWrapper.startService:776 android.rockchip.update.service.RKUpdateReceiver.onReceive:65 android.app.ActivityThread.handleReceiver:4375
08-30 00:15:38.241  1499  1499 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1825 android.content.ContextWrapper.startService:776 android.content.ContextWrapper.startService:776 com.rockchip.devicetest.BootReceiver.onReceive:37 android.app.ActivityThread.handleReceiver:4375
08-30 00:15:38.245  1535  1535 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1825 android.content.ContextWrapper.startService:776 android.content.ContextWrapper.startService:776 android.rockchip.update.service.RKUpdateReceiver.onReceive:74 android.app.ActivityThread.handleReceiver:4375

08-30 00:15:42.325   590   617 W BroadcastQueue: Target SDK mismatch: receiver ActivityInfo{a04775a android.rockchip.update.service.RKUpdateReceiver} targets 27 but delivery restricted to [0, 23] broadcasting Intent { act=android.net.conn.CONNECTIVITY_CHANGE flg=0x4200010 (has extras) } from android (pid=590, uid=1000) to android.rockchip.update.service/.RKUpdateReceiver

08-30 00:15:50.997   590   617 I ActivityManager: Waited long enough for: ServiceRecord{99d047f u0 com.rockchip.devicetest/.service.TestService}
08-30 00:15:51.051   590   617 I ActivityManager: Waited long enough for: ServiceRecord{d06f481 u0 android.rockchip.update.service/.RKUpdateService}
08-30 00:55:52.360   590   668 D ActivityManager: freezing 1535 android.rockchip.update.service
08-30 00:55:52.360   590   668 D ActivityManager: froze 1535 android.rockchip.update.service
08-30 00:55:52.363   590   668 D ActivityManager: freezing 1499 com.rockchip.devicetest
08-30 00:55:52.364   590   668 D ActivityManager: froze 1499 com.rockchip.devicetest

Note: "WiFi starts working AFTER “Target SDK mismatch” logcat message:

08-30 00:15:42.891  1019  1019 W         : [dhd] [wlan0] wl_conn_debug_info : Connecting with 3c:84:6a:8f:7e:bf ssid "Sentinel24G", len (11), channel=5g-36(chan_cnt=1), sec=wpa2/psk/mfpn/aes, rssi=-66

Here is section of logcat around the time when WiFi begins to work. Note the strong correlation between odd device behavior and the errors thrown around android.rockchip.update.service and com.rockchip.devicetest:

08-30 00:15:36.711   590   618 I ActivityManager: Start proc 1795:cn.com.factorytest/1000 for broadcast {cn.com.factorytest/cn.com.factorytest.FactoryReceiver}
08-30 00:15:36.720   590  1033 D CompatibilityChangeReporter: Compat change id reported: 168419799; UID 1000; state: DISABLED
08-30 00:15:36.733   590  1033 I ActivityManager: Killing 1555:com.android.calendar/u0a56 (adj 975): empty #17
08-30 00:15:36.734   590  1033 D CompatibilityChangeReporter: Compat change id reported: 168419799; UID 1000; state: DISABLED
08-30 00:15:37.412   590   610 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
08-30 00:15:37.417   590   610 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
08-30 00:15:37.418   590   610 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
08-30 00:15:37.419   590   610 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
08-30 00:15:38.241  1499  1499 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1825 android.content.ContextWrapper.startService:776 android.08-30 00:15:38.245  1535  1535 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1825 android.content.ContextWrapper.startService:776 android.08-30 00:15:38.470   590  1259 D CompatibilityChangeReporter: Compat change id reported: 135634846; UID 1000; state: DISABLED
08-30 00:15:38.471   590  1259 D CompatibilityChangeReporter: Compat change id reported: 177438394; UID 1000; state: DISABLED
08-30 00:15:38.471   590  1259 D CompatibilityChangeReporter: Compat change id reported: 135772972; UID 1000; state: DISABLED
08-30 00:15:38.472   590  1259 D CompatibilityChangeReporter: Compat change id reported: 135754954; UID 1000; state: ENABLED
08-30 00:15:38.482   590   618 I ActivityManager: Start proc 1815:com.android.localtransport/1000 for service {com.android.localtransport/com.android.localtransport.LocalTransportService}
08-30 00:15:38.520   590   590 I TransportClient: LocalTransportService#0: Notifying [TransportManager.registerTransport()] transport = IBackupTransport
08-30 00:15:38.521   590  1259 D BackupTransportManager: Transport com.android.localtransport/.LocalTransportService registered
08-30 00:15:38.521   590  1259 D BackupManagerService: [UserID:0] Transport com.android.localtransport/.LocalTransport registered 3056ms after first request (delay = 3000ms)
08-30 00:15:38.523   590  1259 I BackupManagerService: [UserID:0] Found 4 stale backup journal(s), scheduling.
08-30 00:15:38.524   590   866 I ActivityManager: Killing 1572:com.android.camera2/u0a48 (adj 975): empty #17
08-30 00:15:38.530   590  1259 I BackupManagerService: [UserID:0] Stale backup journals: Scheduled 12 package(s) total
08-30 00:15:39.401   510   510 W wificond: Scan is not started. Ignore abort request
08-30 00:15:42.890  1019  1019 W         : [dhd] [wlan0] wl_ext_set_chanspec : channel 5g-36(0xe02a 80MHz)
08-30 00:15:42.891  1019  1019 W         : [dhd] [wlan0] wl_conn_debug_info : Connecting with 3c:84:6a:8f:7e:bf ssid "Sentinel24G", len (11), channel=5g-36(chan_cnt=1), sec=wpa2/psk/mfpn/aes, rssi=-66
08-30 00:15:43.997  1488  1488 W         : [dhd] [wlan0] wl_iw_event : Link UP with 3c:84:6a:8f:7e:bf
08-30 00:15:43.997  1488  1488 W         : [dhd] [wlan0] wl_ext_iapsta_link : [S] Link UP with 3c:84:6a:8f:7e:bf
08-30 00:15:43.997     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:43.997     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.001   210   210 W         : [dhd] [wlan0] wl_bss_connect_done : Report connect result - connection succeeded
08-30 00:15:44.006     0     0 W         : [    C5] [dhd] dhd_prot_flow_ring_create: Send Flow Create Req flow ID 41 for peer 3c:84:6a:8f:7e:bf prio 3 ifindex 0 items 512
08-30 00:15:44.006     0     0 W         : [    C0] [dhd] dhd_prot_flow_ring_create_response_process: Flow Create Response status = 0 Flow 41
08-30 00:15:44.024     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.024     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.025  1019  1019 W         : [dhd] [wlan0] wl_add_keyext : key index (0) for 3c:84:6a:8f:7e:bf
08-30 00:15:40.626   590  1181 D CompatibilityChangeReporter: Compat change id reported: 171306433; UID 1000; state: ENABLED
08-30 00:15:44.126     0     0 W         : [    C6] [dhd] dhd_prot_flow_ring_create: Send Flow Create Req flow ID 40 for peer 33:33:ff:39:bd:13 prio 0 ifindex 0 items 512
08-30 00:15:44.126     0     0 W         : [    C0] [dhd] dhd_prot_flow_ring_create_response_process: Flow Create Response status = 0 Flow 40
08-30 00:15:44.235     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.443     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.646     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.750     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:41.468   590   866 I ActivityManager: Killing 1230:com.android.deskclock/u0a59 (adj 975): empty #17
08-30 00:15:45.055     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:45.260     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:42.231   400   440 E NetlinkEvent: NetlinkEvent::FindParam(): Parameter 'INTERFACE' not found
08-30 00:15:44.006     0     0 W         : [    C0] [dhd] dhd_prot_flow_ring_create_response_process: Flow Create Response status = 0 Flow 41
08-30 00:15:44.024     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.024     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.025  1019  1019 W         : [dhd] [wlan0] wl_add_keyext : key index (0) for 3c:84:6a:8f:7e:bf
08-30 00:15:40.626   590  1181 D CompatibilityChangeReporter: Compat change id reported: 171306433; UID 1000; state: ENABLED
08-30 00:15:44.126     0     0 W         : [    C6] [dhd] dhd_prot_flow_ring_create: Send Flow Create Req flow ID 40 for peer 33:33:ff:39:bd:13 prio 0 ifindex 0 items 512
08-30 00:15:44.126     0     0 W         : [    C0] [dhd] dhd_prot_flow_ring_create_response_process: Flow Create Response status = 0 Flow 40
08-30 00:15:44.235     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.443     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.646     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:44.750     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:41.468   590   866 I ActivityManager: Killing 1230:com.android.deskclock/u0a59 (adj 975): empty #17
08-30 00:15:45.055     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:45.260     0     0 W         : NOHZ tick-stop error: Non-RCU local softirq work is pending, handler #08!!!
08-30 00:15:42.231   400   440 E NetlinkEvent: NetlinkEvent::FindParam(): Parameter 'INTERFACE' not found
08-30 00:15:42.231   400   440 E NetlinkEvent: NetlinkEvent::FindParam(): Parameter 'STATE' not found
08-30 00:15:42.231   400   440 E NetlinkEvent: NetlinkEvent::FindParam(): Parameter 'TIME_NS' not found
08-30 00:15:42.231   400   440 E NetlinkEvent: NetlinkEvent::FindParam(): Parameter 'UID' not found
08-30 00:15:42.324   590   695 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendStickyBroadcast:1568 com.android.server.ConnectivityService.sendSticky08-30 00:15:42.325   590   617 W BroadcastQueue: Target SDK mismatch: receiver ActivityInfo{a04775a android.rockchip.update.service.RKUpdateReceiver} targets 27 but delivery restricted to [0, 23] broadcasting 08-30 00:15:42.407   590   610 I DropBoxManagerService: add tag=system_server_strictmode isTagEnabled=true flags=0x2                                                                                             08-30 00:15:42.842   590   695 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendStickyBroadcast:1568 com.android.server.ConnectivityService.sendSticky08-30 00:15:43.025   590   610 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
08-30 00:15:50.995     0     0 I [    C1] nf_conntrack: default automatic helper assignment has been turned off for security reasons and CT-based  firewall rule not found. Use the iptables CT target to attach
08-30 00:15:50.997   590   617 I ActivityManager: Waited long enough for: ServiceRecord{99d047f u0 com.rockchip.devicetest/.service.TestService}
08-30 00:15:51.051   590   617 I ActivityManager: Waited long enough for: ServiceRecord{d06f481 u0 android.rockchip.update.service/.RKUpdateService}
08-30 00:15:56.692   419   419 W healthd : battery l=50 v=3 t=2.6 h=2 st=3 c=-1600 fc=100 chg=au
08-30 00:15:53.472   590   617 I DropBoxManagerService: add tag=system_server_wtf isTagEnabled=true flags=0x2
08-30 00:15:56.929   520   520 I dwc3 fc000000.usb: device reset
08-30 00:15:53.473   590   674 D WindowManager: dp plugged state change, name=extcon0 plugged=true
08-30 00:15:53.474   590   617 I DropBoxManagerService: add tag=system_server_wtf isTagEnabled=true flags=0x2
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:53.475   590   674 D WiredAccessoryManager: state.contains(CDP=) return
08-30 00:15:56.952    15    15 I android_work: sent uevent USB_STATE=CONNECTED

What are com.rockchip.devicetest & android.rockchip.update.service? Can they be disabled, uninstalled, and/or removed?

I’ve started to observe the following error message too:

Rk-DeviceTest-Failure

Since doing a “Force Stop”, “Clear Cache”, and “Clear Something Else”, this message has gone away.

Has anyone seen this before? I haven’t changed anything else in the source code (aside from the WifiCountryCode=US mod in another post). Appreciate some help. Thanks.

vendor/rockchip/common/apps$ git diff
diff --git a/apps/apps.mk b/apps/apps.mk
old mode 100755
new mode 100644
index 75986b5..37a4256
--- a/apps/apps.mk
+++ b/apps/apps.mk
@@ -1,19 +1,5 @@
 
 
-PRODUCT_PACKAGES += \
-    RKUpdateService
-
-ifeq ($(strip $(TARGET_BOARD_HARDWARE)), rk30board)
-ifeq ($(strip $(TARGET_ARCH)), arm)
-PRODUCT_COPY_FILES += \
-       vendor/rockchip/common/apps/RKUpdateService/lib/arm/librockchip_update_jni.so:system/lib/librockchip_update_jni.so
-else ifeq ($(strip $(TARGET_ARCH)), arm64)
-PRODUCT_COPY_FILES += \
-       vendor/rockchip/common/apps/RKUpdateService/lib/arm/librockchip_update_jni.so:system/lib/librockchip_update_jni.so \
-       vendor/rockchip/common/apps/RKUpdateService/lib/arm64/librockchip_update_jni.so:system/lib64/librockchip_update_jni.so
-endif
-endif
-
 ifneq ($(strip $(BUILD_WITH_GOOGLE_MARKET)), true)
 PRODUCT_PACKAGES += \
               Lightning
@@ -60,21 +46,6 @@ endif
 endif
 
 
-ifeq ($(strip $(BOARD_HAS_STRESSTEST_APP)), true)
-    PRODUCT_PACKAGES += \
-    StressTest 
-
-ifneq ($(filter atv box, $(strip $(TARGET_BOARD_PLATFORM_PRODUCT))), )
-PRODUCT_PACKAGES += \
-    RKDeviceTest
-
-else
-PRODUCT_PACKAGES += \
-    DeviceTest
-
-endif
-endif
-

@goenjoy

$ cd ~/WORKING_DIRECTORY/vendor/rockchip/common/apps
$ cp apps.mk apps-bak.mk
$ nano apps.mk
$ diff apps-bak.mk apps.mk
λ diff apps-bak.mk apps.mk
3,16d2
< PRODUCT_PACKAGES += \
<     RKUpdateService
<
< ifeq ($(strip $(TARGET_BOARD_HARDWARE)), rk30board)
< ifeq ($(strip $(TARGET_ARCH)), arm)
< PRODUCT_COPY_FILES += \
<        vendor/rockchip/common/apps/RKUpdateService/lib/arm/librockchip_update_jni.so:system/lib/librockchip_update_jni.so
< else ifeq ($(strip $(TARGET_ARCH)), arm64)
< PRODUCT_COPY_FILES += \
<        vendor/rockchip/common/apps/RKUpdateService/lib/arm/librockchip_update_jni.so:system/lib/librockchip_update_jni.so \
<        vendor/rockchip/common/apps/RKUpdateService/lib/arm64/librockchip_update_jni.so:system/lib64/librockchip_update_jni.so
< endif
< endif
<
62,76d47
<
< ifeq ($(strip $(BOARD_HAS_STRESSTEST_APP)), true)
<     PRODUCT_PACKAGES += \
<     StressTest
<
< ifneq ($(filter atv box, $(strip $(TARGET_BOARD_PLATFORM_PRODUCT))), )
< PRODUCT_PACKAGES += \
<     RKDeviceTest
<
< else
< PRODUCT_PACKAGES += \
<     DeviceTest
<
< endif
< endif
$ make clean
$ reboot
$ source build/envsetup.sh
$ lunch kedge2-userdebug
$ make -j1

It’s currently building. More to follow.