Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

device offline on aliyun arm64 ecs 5.10.60-9.al8.aarch64 #45

Closed
yuklin opened this issue Oct 13, 2021 · 12 comments
Closed

device offline on aliyun arm64 ecs 5.10.60-9.al8.aarch64 #45

yuklin opened this issue Oct 13, 2021 · 12 comments
Assignees
@zhouziyang
Labels
bug Something isn't working

Comments

@yuklin
Copy link

yuklin commented Oct 13, 2021

Modules check: ok
lsmod | grep -e binder -e ashmem
binder_linux 204800 50
ashmem_linux 24576 15521

binder mount check: ok
ll /dev/binderfs/
总用量 0
crw------- 1 root root 244, 1 10月 13 13:28 binder
crw------- 1 root root 244, 0 10月 13 13:28 binder-control
crw------- 1 root root 244, 2 10月 13 13:28 hwbinder
crw------- 1 root root 244, 3 10月 13 13:28 vndbinder

docker run cmd is:
docker run --name test -itd --rm --memory-swappiness=0 --privileged -v /home/p_data/2:/data -p 1000:5555 c970022c4d04 redroid.gpu.mode=guest

adb connect port: ok

./adb connect 127.0.0.1:1000
connected to 127.0.0.1:1000

ad devices: NO OK
./adb devices
List of devices attached
127.0.0.1:1000 offline

binder_linux dmesg log:

[三 10月 13 14:47:39 2021] binder_linux: undelivered TRANSACTION_COMPLETE
[三 10月 13 14:47:39 2021] binder_linux: release 21284:21379 transaction 5864557 in, still active
[三 10月 13 14:47:39 2021] binder_linux: send failed reply for transaction 5864557 to 21407:21543
[三 10月 13 14:47:39 2021] binder_linux: release 21284:21523 transaction 5866778 in, still active
[三 10月 13 14:47:39 2021] binder_linux: send failed reply for transaction 5866778 to 21407:21407
[三 10月 13 14:47:39 2021] binder_linux: release 21284:21525 transaction 5866783 in, still active
[三 10月 13 14:47:39 2021] binder_linux: send failed reply for transaction 5866783 to 21431:21519
[三 10月 13 14:47:39 2021] binder_linux: send failed reply for transaction 5866790 to 21563:21563
[三 10月 13 14:47:39 2021] binder_linux: 35900:35953 transaction failed 29189/-22, size 68-0 line 2961
[三 10月 13 14:47:39 2021] binder_linux: 35900:35953 transaction failed 29189/-22, size 68-0 line 2961
[三 10月 13 14:47:39 2021] binder_linux: 21431:21519 transaction failed 29189/-22, size 2488-8 line 2961
[三 10月 13 14:47:39 2021] binder_linux: 21407:21597 transaction failed 29189/-22, size 92-0 line 2961
[三 10月 13 14:47:39 2021] binder_linux: 21407:21555 transaction failed 29189/-22, size 2000-8 line 2961
[三 10月 13 14:47:39 2021] binder_linux: undelivered TRANSACTION_COMPLETE
[三 10月 13 14:47:39 2021] binder_linux: undelivered transaction 5867545, process died.
[三 10月 13 14:47:39 2021] binder_linux: 35900:36388 transaction failed 29189/-22, size 68-0 line 2961
[三 10月 13 14:47:39 2021] binder_linux: 35900:36388 transaction failed 29189/-22, size 68-0 line 2961
[三 10月 13 14:47:39 2021] binder_linux: 21267:21267 transaction failed 29189/0, size 4-0 line 2893
[三 10月 13 14:47:39 2021] binder_linux: send failed reply for transaction 5861310, target dead
[三 10月 13 14:47:44 2021] binder_linux: release 21662:21742 transaction 5871062 out, still active
[三 10月 13 14:47:44 2021] binder_linux: undelivered TRANSACTION_COMPLETE
[三 10月 13 14:47:44 2021] binder_linux: send failed reply for transaction 5876996 to 21784:21784
[三 10月 13 14:47:44 2021] binder_linux: release 21662:21898 transaction 5876148 in, still active
[三 10月 13 14:47:44 2021] binder_linux: send failed reply for transaction 5876148 to 21784:21931
[三 10月 13 14:47:44 2021] binder_linux: release 21662:21902 transaction 5876980 in, still active
[三 10月 13 14:47:44 2021] binder_linux: send failed reply for transaction 5876980 to 21784:21901
[三 10月 13 14:47:44 2021] binder_linux: send failed reply for transaction 5877017 to 21983:21983
[三 10月 13 14:47:44 2021] binder_linux: send failed reply for transaction 5877233 to 21957:21957
[三 10月 13 14:47:44 2021] binder_linux: 35900:36191 transaction failed 29189/-22, size 68-0 line 2961
[三 10月 13 14:47:44 2021] binder_linux: 35900:36191 transaction failed 29189/-22, size 68-0 line 2961
[三 10月 13 14:47:44 2021] binder_linux: 21784:22019 transaction failed 29189/-22, size 92-0 line 2961
[三 10月 13 14:47:44 2021] binder_linux: 21983:21983 transaction failed 29189/-22, size 3048-8 line 2961
[三 10月 13 14:47:44 2021] binder_linux: 21642:21642 transaction failed 29189/0, size 4-0 line 2893
[三 10月 13 14:47:44 2021] binder_linux: send failed reply for transaction 5871062, target dead
[三 10月 13 14:47:44 2021] binder_linux: 35900:36191 transaction failed 29189/-22, size 68-0 line 2961
[三 10月 13 14:47:44 2021] binder_linux: 35900:36191 transaction failed 29189/-22, size 68-0 line 2961

docker version is docker-ce 20.10.9, build c2ea9bc

podman docker has something wrong with port forwarding so i replace podman with docker-ce

anything you need ?
@yuklin
Copy link
Author

yuklin commented Oct 13, 2021 •
edited
Loading

i have tried 12 11 10
12 11 will be offlined

but 10 online works

@zhouziyang
Copy link
Member

get redroid shell via docker exec -it <container-id> sh

try to collect the following info:
ps -A
logcat / logcat -b crash
dmesg -T

BTW, DO NOT mount the same directory as data partition for different redroid instance,

@yuklin
Copy link
Author

yuklin commented Oct 13, 2021

log.tar.gz
use redroid/redroid:11.0.0-arm64

@zhouziyang
Copy link
Member

system_server crashed

10-13 08:26:58.668  1176  1203 E AndroidRuntime: *** FATAL EXCEPTION IN SYSTEM PROCESS: android.bg
10-13 08:26:58.668  1176  1203 E AndroidRuntime: android.os.ServiceSpecificException: Read value of map -1 failed: Operation not permitted (code 1)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.Parcel.createExceptionOrNull(Parcel.java:2387)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.Parcel.createException(Parcel.java:2357)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.Parcel.readException(Parcel.java:2340)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.Parcel.readException(Parcel.java:2282)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.net.INetd$Stub$Proxy.trafficSwapActiveStatsMap(INetd.java:3652)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsFactory.requestSwapActiveStatsMapLocked(NetworkStatsFactory.java:304)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsFactory.readNetworkStatsDetail(NetworkStatsFactory.java:331)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsService.readNetworkStatsUidDetail(NetworkStatsService.java:1864)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsService.getNetworkStatsUidDetail(NetworkStatsService.java:1880)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsService.recordSnapshotLocked(NetworkStatsService.java:1389)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsService.performPollLocked(NetworkStatsService.java:1508)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsService.performPoll(NetworkStatsService.java:1459)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsService.openSessionInternal(NetworkStatsService.java:656)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.net.NetworkStatsService.openSessionForUsageStats(NetworkStatsService.java:627)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.stats.pull.StatsPullAtomService.getNetworkStatsSession(StatsPullAtomService.java:892)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.stats.pull.StatsPullAtomService.getUidNetworkStatsSnapshotForTemplate(StatsPullAtomService.java:1222)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.stats.pull.StatsPullAtomService.getUidNetworkStatsSnapshotForTransport(StatsPullAtomService.java:1201)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.stats.pull.StatsPullAtomService.collectNetworkStatsSnapshotForAtom(StatsPullAtomService.java:1007)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.stats.pull.StatsPullAtomService.initAndRegisterNetworkStatsPullers(StatsPullAtomService.java:850)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.stats.pull.StatsPullAtomService.lambda$onBootPhase$1$StatsPullAtomService(StatsPullAtomService.java:682)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at com.android.server.stats.pull.-$$Lambda$StatsPullAtomService$w2J9UcZX1E4P1ogWSvuoTC2auDE.run(Unknown Source:2)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.Handler.handleCallback(Handler.java:938)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.Handler.dispatchMessage(Handler.java:99)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.Looper.loop(Looper.java:223)
10-13 08:26:58.668  1176  1203 E AndroidRuntime:        at android.os.HandlerThread.run(HandlerThread.java:67)

@zhouziyang zhouziyang self-assigned this Oct 13, 2021
@zhouziyang zhouziyang added the bug Something isn't working label Oct 13, 2021
@zhouziyang zhouziyang mentioned this issue Oct 15, 2021
Closed
@zhouziyang
Copy link
Member

@yuklin fixed for redroid11 and redroid12. kind of workaround in netd since lacking traffic control in generic kernel. please check in your side.

@yuklin
Copy link
Author

yuklin commented Oct 18, 2021

@zhouziyang awsome, i will check it later today

@yuklin
Copy link
Author

yuklin commented Oct 18, 2021

redroid11 and redroid12 runs successfully in docker now

But i find out that redroid12 instance's app (webview or other apps i install manual) can not connect to internet, meanwhile in shell i run ping the network works fine with 114.114.114.114 and www.baidu.com.

@yuklin
Copy link
Author

yuklin commented Oct 18, 2021

--------- beginning of crash
10-18 03:20:28.900 2197 2197 E AndroidRuntime: FATAL EXCEPTION: main
10-18 03:20:28.900 2197 2197 E AndroidRuntime: Process: com.android.settings, PID: 2197
10-18 03:20:28.900 2197 2197 E AndroidRuntime: java.lang.RuntimeException: Unable to start activity ComponentInfo{com.android.settings/com.android.settings.SubSettings}: java.lang.NullPointerException: Attempt to invoke virtual method 'java.util.List android.hardware.usb.UsbManager.getPorts()' on a null object reference
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:3635)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.ActivityThread.handleLaunchActivity(ActivityThread.java:3792)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.servertransaction.LaunchActivityItem.execute(LaunchActivityItem.java:103)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.servertransaction.TransactionExecutor.executeCallbacks(TransactionExecutor.java:135)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:95)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2210)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.os.Handler.dispatchMessage(Handler.java:106)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.os.Looper.loopOnce(Looper.java:201)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.os.Looper.loop(Looper.java:288)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.ActivityThread.main(ActivityThread.java:7838)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at java.lang.reflect.Method.invoke(Native Method)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:548)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:1003)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: Caused by: java.lang.NullPointerException: Attempt to invoke virtual method 'java.util.List android.hardware.usb.UsbManager.getPorts()' on a null object reference
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.connecteddevice.usb.UsbBackend.updatePorts(UsbBackend.java:220)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.connecteddevice.usb.UsbBackend.(UsbBackend.java:80)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.connecteddevice.usb.UsbBackend.(UsbBackend.java:63)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.connecteddevice.usb.ConnectedUsbDeviceUpdater.(ConnectedUsbDeviceUpdater.java:70)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.connecteddevice.ConnectedDeviceGroupController.init(ConnectedDeviceGroupController.java:139)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.connecteddevice.ConnectedDeviceDashboardFragment.onAttach(ConnectedDeviceDashboardFragment.java:68)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at androidx.fragment.app.Fragment.performAttach(Fragment.java:2912)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at androidx.fragment.app.FragmentStateManager.attach(FragmentStateManager.java:440)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at androidx.fragment.app.FragmentStateManager.moveToExpectedState(FragmentStateManager.java:251)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at androidx.fragment.app.FragmentManager.executeOpsTogether(FragmentManager.java:2209)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at androidx.fragment.app.FragmentManager.removeRedundantOperationsAndExecute(FragmentManager.java:2120)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at androidx.fragment.app.FragmentManager.execPendingActions(FragmentManager.java:2022)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at androidx.fragment.app.FragmentManager.executePendingTransactions(FragmentManager.java:603)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.SettingsActivity.switchToFragment(SettingsActivity.java:596)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.SettingsActivity.launchSettingFragment(SettingsActivity.java:381)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at com.android.settings.SettingsActivity.onCreate(SettingsActivity.java:282)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.Activity.performCreate(Activity.java:8051)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.Activity.performCreate(Activity.java:8031)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.Instrumentation.callActivityOnCreate(Instrumentation.java:1329)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:3608)
10-18 03:20:28.900 2197 2197 E AndroidRuntime: ... 12 more

redroid12 crash log

@zhouziyang
Copy link
Member

zhouziyang commented Oct 18, 2021 via email

@zhouziyang
Copy link
Member

zhouziyang commented Oct 18, 2021 via email

@zhouziyang
Copy link
Member

@yuklin this issue (app cannot access internet) seems fixed by Android (code base upgraded).

@yuklin
Copy link
Author

yuklin commented Feb 8, 2022

roger that and thank you, i will check later

@chinese-wzq chinese-wzq mentioned this issue Nov 7, 2022
Open
@xxlovex xxlovex mentioned this issue Dec 24, 2023
Open
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@zhouziyang zhouziyang

Labels
bug Something isn't working
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@zhouziyang @yuklin