Skip to content
This repository has been archived by the owner on Feb 13, 2024. It is now read-only.

Android doesn't start, looks like a boot loop #353

Closed
gasinvein opened this issue Jul 12, 2017 · 7 comments
Closed

Android doesn't start, looks like a boot loop #353

gasinvein opened this issue Jul 12, 2017 · 7 comments
Assignees
@morphis
Labels
android container

Comments

@gasinvein
Copy link

Anbox shows no errors, but Android doesn't start and seems like having a boot loop.

dmesg:
(messages like those after healthd: battery l=100 v=0 t=42.4 h=2 st=2 chg=a repeat continuously)

[ 2144.229214] anbox0: port 1(veth5UYDY4) entered blocking state
[ 2144.229219] anbox0: port 1(veth5UYDY4) entered disabled state
[ 2144.229265] device veth5UYDY4 entered promiscuous mode
[ 2144.229372] IPv6: ADDRCONF(NETDEV_UP): veth5UYDY4: link is not ready
[ 2144.271338] eth0: renamed from veth761KLQ
[ 2144.300346] IPv6: ADDRCONF(NETDEV_CHANGE): veth5UYDY4: link becomes ready
[ 2144.300399] anbox0: port 1(veth5UYDY4) entered blocking state
[ 2144.300402] anbox0: port 1(veth5UYDY4) entered listening state
[ 2144.599990] init: init first stage started!
[ 2144.600317] init: init second stage started!
[ 2144.602040] init: Running restorecon...
[ 2144.602060] init: waitpid failed: No child processes
[ 2144.602115] init: (Loading properties from /default.prop took 0.00s.)
[ 2144.602471] init: (Parsing /init.environ.rc took 0.00s.)
[ 2144.602547] init: (Parsing /init.usb.rc took 0.00s.)
[ 2144.602587] init: (Parsing /init.goldfish.rc took 0.00s.)
[ 2144.602614] init: (Parsing /init.zygote64_32.rc took 0.00s.)
[ 2144.602616] init: (Parsing /init.rc took 0.00s.)
[ 2144.602642] init: write_file: Unable to open '/proc/sys/kernel/sysrq': Read-only file system
[ 2144.604424] ueventd: ueventd started!
[ 2144.606868] ueventd: Coldboot took 0.00s.
[ 2144.613951] new mount options do not match the existing superblock, will be ignored
[ 2144.817910] fs_mgr: No entries found in fstab
[ 2145.200838] healthd: No battery devices found
[ 2154.758223] healthd: battery l=100 v=0 t=42.4 h=2 st=2 chg=a
[ 2154.990348] init: write_file: Unable to open '/proc/sys/vm/extra_free_kbytes': No such file or directory
[ 2155.578852] init: write_file: Unable to open '/proc/sys/net/ipv4/tcp_default_init_rwnd': No such file or directory
[ 2156.389529] binder_linux: 9211: binder_alloc_buf, no vma
[ 2156.389534] binder_linux: 9115:9178 transaction failed 29201, size 68-0
[ 2156.398226] binder_linux: 9211: binder_alloc_buf, no vma
[ 2156.398230] binder_linux: 9115:9180 transaction failed 29201, size 68-0
[ 2156.410513] binder_linux: send failed reply for transaction 152545 to 9359:9359
[ 2156.410797] binder_linux: 9115:9181 transaction failed 29189, size 68-0
[ 2156.411365] binder_linux: 9359:9359 transaction failed 29189, size 4020-8
[ 2156.446303] init: Service 'zygote' (pid 36) killed by signal 9
[ 2156.446308] init: Service 'zygote' (pid 36) killing any children in process group
[ 2156.446397] init: Service 'audioserver' is being killed...
[ 2156.446991] init: Service 'cameraserver' is being killed...
[ 2156.447004] init: Service 'media' is being killed...
[ 2156.447024] init: Service 'netd' is being killed...
[ 2156.447183] init: Starting service 'zygote'...
[ 2156.448864] init: Service 'audioserver' (pid 38) killed by signal 9
[ 2157.209211] healthd: battery l=100 v=0 t=42.4 h=2 st=2 chg=a
[ 2158.007410] binder_linux: 9438: binder_alloc_buf, no vma
[ 2158.007415] binder_linux: 9115:9178 transaction failed 29201, size 68-0
[ 2158.011074] binder_linux: 9438: binder_alloc_buf, no vma
[ 2158.011078] binder_linux: 9115:9180 transaction failed 29201, size 68-0
[ 2158.027052] binder_linux: 9115:9181 transaction failed 29189, size 68-0
[ 2158.037957] binder_linux: 9577:9577 transaction failed 29189, size 12196-64
[ 2159.553972] anbox0: port 1(veth5UYDY4) entered learning state
[ 2161.063346] init: Starting service 'zygote'...
[ 2161.064385] init: Starting service 'audioserver'...
[ 2161.065356] init: Starting service 'cameraserver'...
[ 2161.066027] init: couldn't write 508 to /dev/cpuset/camera-daemon/tasks: No such file or directory
[ 2161.066546] init: Starting service 'media'...
[ 2161.067769] init: Starting service 'netd'...
[ 2162.081095] healthd: battery l=100 v=0 t=42.4 h=2 st=2 chg=a
[ 2162.166274] init: write_file: Unable to open '/proc/sys/vm/extra_free_kbytes': No such file or directory
[ 2162.606317] init: write_file: Unable to open '/proc/sys/net/ipv4/tcp_default_init_rwnd': No such file or directory
[ 2162.902377] binder_linux: 9669: binder_alloc_buf, no vma
[ 2162.902381] binder_linux: 9115:9178 transaction failed 29201, size 68-0
[ 2162.906169] binder_linux: 9669: binder_alloc_buf, no vma
[ 2162.906173] binder_linux: 9782:9782 transaction failed 29201, size 288-16
[ 2162.906700] binder_linux: 9669: binder_alloc_buf, no vma
[ 2162.906703] binder_linux: 9782:9782 transaction failed 29201, size 3708-8
[ 2162.911117] binder_linux: 9669: binder_alloc_buf, no vma
[ 2162.911122] binder_linux: 9115:9180 transaction failed 29201, size 68-0
[ 2162.924305] binder_linux: 9669: binder_alloc_buf, no vma
[ 2162.924311] binder_linux: 9831:9831 transaction failed 29201, size 92-8
[ 2162.925708] binder_linux: 9669: binder_alloc_buf, no vma
[ 2162.925712] binder_linux: 9831:9831 transaction failed 29201, size 144-8
[ 2162.926182] binder_linux: 9669: binder_alloc_buf, no vma
[ 2162.926184] binder_linux: 9831:9831 transaction failed 29201, size 1940-8
[ 2162.926695] binder_linux: 9115:9181 transaction failed 29189, size 68-0
[ 2162.951652] binder_linux: 9815:9815 transaction failed 29189, size 124-8
[ 2162.974132] init: Service 'zygote' (pid 506) killed by signal 9
[ 2162.974137] init: Service 'zygote' (pid 506) killing any children in process group
[ 2166.731505] healthd: battery l=100 v=0 t=42.4 h=2 st=2 chg=a
[ 2166.822662] init: write_file: Unable to open '/proc/sys/vm/extra_free_kbytes': No such file or directory
[ 2167.272888] init: write_file: Unable to open '/proc/sys/net/ipv4/tcp_default_init_rwnd': No such file or directory
[ 2167.544906] binder_linux: 9902: binder_alloc_buf, no vma
[ 2167.544910] binder_linux: 9115:9178 transaction failed 29201, size 68-0
[ 2167.553730] binder_linux: 9902: binder_alloc_buf, no vma
[ 2167.553735] binder_linux: 10086:10086 transaction failed 29201, size 3000-24
[ 2167.554267] binder_linux: 9902: binder_alloc_buf, no vma
[ 2167.554269] binder_linux: 10086:10086 transaction failed 29201, size 1932-8
[ 2167.558399] binder_linux: send failed reply for transaction 157950 to 10017:10017
[ 2167.558403] binder_linux: send failed reply for transaction 157956 to 10047:10047
[ 2167.558996] binder_linux: 10017:10017 transaction failed 29189, size 3312-8
[ 2167.559533] binder_linux: 10047:10047 transaction failed 29189, size 3336-8
[ 2167.582051] binder_linux: 9128:9194 transaction failed 29189, size 60-0
[ 2167.582085] init: Service 'zygote' (pid 722) killed by signal 9
[ 2167.582088] init: Service 'zygote' (pid 722) killing any children in process group
[ 2167.582127] init: Service 'audioserver' is being killed...
[ 2167.582260] init: Service 'cameraserver' is being killed...
[ 2167.582274] init: Service 'media' is being killed...
[ 2167.582299] init: Service 'netd' is being killed...
[ 2167.583081] init: Service 'audioserver' (pid 723) killed by signal 9
[ 2167.583084] init: Service 'audioserver' (pid 723) killing any children in process group
[ 2167.598593] binder_linux: 9115:9180 transaction failed 29189, size 68-0

anbox system-info:

version: local-/bin/sh: git: command not found
os:
  name: openSUSE Tumbleweed
  version: 
  snap-based: false
kernel:
  version: Linux version 4.11.8-1-default (geeko@buildhost) (gcc version 7.1.1 20170629 [gcc-7-branch revision 249772] (SUSE Linux) ) #1 SMP PREEMPT Thu Jun 29 14:37:33 UTC 2017 (42bd7a0)
  binder: true
  ashmem: true
graphics:
  egl:
    vendor: NVIDIA
    version: 1.4
    extensions:
      - EGL_EXT_buffer_age
      - EGL_EXT_create_context_robustness
      - EGL_EXT_output_base
      - EGL_EXT_stream_acquire_mode
      - EGL_IMG_context_priority
      - EGL_KHR_config_attribs
      - EGL_KHR_create_context_no_error
      - EGL_KHR_create_context
      - EGL_KHR_fence_sync
      - EGL_KHR_get_all_proc_addresses
      - EGL_KHR_partial_update
      - EGL_KHR_swap_buffers_with_damage
      - EGL_KHR_gl_renderbuffer_image
      - EGL_KHR_gl_texture_2D_image
      - EGL_KHR_gl_texture_3D_image
      - EGL_KHR_gl_texture_cubemap_image
      - EGL_KHR_image
      - EGL_KHR_image_base
      - EGL_KHR_image_pixmap
      - EGL_KHR_reusable_sync
      - EGL_KHR_stream
      - EGL_KHR_stream_consumer_gltexture
      - EGL_KHR_stream_cross_process_fd
      - EGL_KHR_stream_fifo
      - EGL_KHR_stream_producer_eglsurface
      - EGL_KHR_surfaceless_context
      - EGL_NV_post_sub_buffer
      - EGL_NV_stream_metadata
      - EGL_NV_stream_sync
      - EGL_NV_stream_consumer_gltexture_yuv
      - EGL_NV_stream_attrib
      - EGL_NV_sync
      - EGL_NV_system_time
      - EGL_NV_output_drm_flip_event
      - EGL_WL_bind_wayland_display
      - EGL_WL_wayland_eglstream
  gles2:
    vendor: NVIDIA Corporation
    vendor: OpenGL ES 1.1 NVIDIA 375.66
    extensions:
      - GL_EXT_debug_label
      - GL_EXT_map_buffer_range
      - GL_EXT_robustness
      - GL_EXT_texture_compression_dxt1
      - GL_EXT_texture_compression_s3tc
      - GL_EXT_texture_format_BGRA8888
      - GL_KHR_debug
      - GL_NV_texture_compression_s3tc
      - GL_OES_compressed_ETC1_RGB8_texture
      - GL_OES_compressed_paletted_texture
      - GL_OES_draw_texture
      - GL_OES_EGL_image
      - GL_OES_EGL_image_external
      - GL_OES_EGL_sync
      - GL_OES_element_index_uint
      - GL_OES_extended_matrix_palette
      - GL_OES_fbo_render_mipmap
      - GL_OES_framebuffer_object
      - GL_OES_matrix_get
      - GL_OES_matrix_palette
      - GL_OES_packed_depth_stencil
      - GL_OES_point_size_array
      - GL_OES_point_sprite
      - GL_OES_rgb8_rgba8
      - GL_OES_read_format
      - GL_OES_stencil8
      - GL_OES_texture_cube_map
      - GL_OES_texture_npot
      - GL_OES_vertex_half_float
@gasinvein gasinvein changed the title Android doesn't start, looks like boot loop Android doesn't start, looks like a boot loop Jul 12, 2017
@mellowcandle
Copy link

I'm experiencing the same. Ubuntu 17.04 host.

@flyflypeng
Copy link

Hello! I want to know how can you get the android log that run in the container.Thank you!

@mellowcandle
Copy link

mellowcandle commented Jul 14, 2017 via email

@gasinvein
Copy link
Author

gasinvein commented Jul 14, 2017 via email •
edited

@morphis
Copy link
Member

morphis commented Jul 14, 2017

Can you also attach the log from $ANBOX_DATA_DIR/data/system.log where ANBOX_DATA_DIR is usually /var/lib/anbox when you don't use the snap. Thanks!

@gasinvein
Copy link
Author

@morphis sure, here it is.

@morphis
Copy link
Member

morphis commented Jul 14, 2017

Thanks! The actual problem is

07-14 13:23:32.161  1131  1131 E AndroidRuntime: java.lang.NullPointerException: Attempt to invoke virtual method 'void android.app.PendingIntent.send()' on a null object reference
07-14 13:23:32.161  1131  1131 E AndroidRuntime: 	at com.android.server.AlarmManagerService$AlarmHandler.handleMessage(AlarmManagerService.java:2625)

which I fixed yesterday with anbox/platform_frameworks_base#1

I will push a new snap with that fix later today.

@morphis morphis self-assigned this Jul 14, 2017
@morphis morphis mentioned this issue Jul 14, 2017
Merged
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees

@morphis morphis

Labels
android container
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@morphis @mellowcandle @gasinvein @flyflypeng