Uploaded image for project: ' AGL Development'
  1. AGL Development
  2. SPEC-5114

[next] Race within applaunchd/gRPC leading to applaunchd crash

XMLWordPrintable

    • Icon: Bug Bug
    • Resolution: Unresolved
    • Icon: Minor Minor
    • None
    • None
    • None
    • None

      I've been seen some weird race, together with a crash for applaunchd on the next branch.

      TIME                        PID  UID  GID SIG     COREFILE EXE                   SIZE
Fri 2024-04-19 08:13:32 UTC 509 1001 1001 SIGABRT present  /usr/bin/launcher     5.1M
Fri 2024-04-19 08:13:34 UTC 610 1001 1001 SIGABRT present  /usr/bin/launcher     6.4M
Fri 2024-04-19 08:13:35 UTC 640 1001 1001 SIGABRT present  /usr/bin/launcher     5.3M
Fri 2024-04-19 08:13:36 UTC 670 1001 1001 SIGABRT present  /usr/bin/launcher     6.4M
Fri 2024-04-19 08:13:37 UTC 702 1001 1001 SIGABRT present  /usr/bin/launcher     6.3M
Fri 2024-04-19 09:14:16 UTC 372 1003 1003 SIGSEGV present  /usr/bin/applaunchd 689.9K

      This a from a fresh reboot. Notice that launcher can't start due to SPEC-5108, and notice the applaunchd crash.

      Here's also the trace:

      #0  0x00007f8f250f35ab in grpc::ServerContextBase::IsCancelled() const () from /usr/lib/libgrpc++.so.1.60
#1  0x00005571b2a61519 in ?? ()
#2  0x00005571b2a617e2 in ?? ()
#3  0x00005571b2a61ac8 in ?? ()
#4  0x00007f8f2625915b in g_cclosure_marshal_VOID__STRINGv () from /usr/lib/libgobject-2.0.so.0
#5  0x00007f8f26256631 in ?? () from /usr/lib/libgobject-2.0.so.0
#6  0x00007f8f2626aac8 in ?? () from /usr/lib/libgobject-2.0.so.0
#7  0x00007f8f262705d2 in g_signal_emit_valist () from /usr/lib/libgobject-2.0.so.0
#8  0x00007f8f2627067f in g_signal_emit () from /usr/lib/libgobject-2.0.so.0
#9  0x00005571b2a623cc in ?? ()
#10 0x00007f8f26256438 in g_closure_invoke () from /usr/lib/libgobject-2.0.so.0
#11 0x00007f8f2626907e in ?? () from /usr/lib/libgobject-2.0.so.0
#12 0x00007f8f2626a9b1 in ?? () from /usr/lib/libgobject-2.0.so.0
#13 0x00007f8f262705d2 in g_signal_emit_valist () from /usr/lib/libgobject-2.0.so.0
#14 0x00007f8f2627067f in g_signal_emit () from /usr/lib/libgobject-2.0.so.0
#15 0x00007f8f2602df87 in ?? () from /usr/lib/libgio-2.0.so.0
#16 0x00007f8f2601b75b in ?? () from /usr/lib/libgio-2.0.so.0
#17 0x00007f8f261524a5 in ?? () from /usr/lib/libglib-2.0.so.0
#18 0x00007f8f26155637 in ?? () from /usr/lib/libglib-2.0.so.0
#19 0x00007f8f26155eef in g_main_loop_run () from /usr/lib/libglib-2.0.so.0
#20 0x00005571b2a48379 in ?? ()
#21 0x00007f8f24bacf3b in __libc_start_call_main (main=main@entry=0x5571b2a48140, argc=argc@entry=1, argv=argv@entry=0x7ffd7a6f6598)
    at /usr/src/debug/glibc/2.39+git/sysdeps/nptl/libc_start_call_main.h:58
#22 0x00007f8f24bacff9 in __libc_start_main_impl (main=0x5571b2a48140, argc=1, argv=0x7ffd7a6f6598, init=<optimized out>, fini=<optimized out>, rtld_fini=<optimized out>, 
    stack_end=0x7ffd7a6f6588) at /usr/src/debug/glibc/2.39+git/csu/libc-start.c:360
#23 0x00005571b2a484f5 in ?? ()

      That happens when I attempt to start the nav app. Here's debug logs from the compositor
      that shows first when launcher is attempting to start, then nav starts, applaunchd dies, with it, homescreen goes away, the compositor installs a black screen then applaunchd starts again and with it homescreen:

      Apr 19 08:13:32 qemux86-64 agl-compositor[386]: [08:13:32.774] Added surface 0x555eea6aa860, app_id homescreen to pending list
Apr 19 08:13:32 qemux86-64 agl-compositor[386]: [08:13:32.974] Removed surface 0x555eea753cc0, app_id launcher, role NONE
Apr 19 08:13:33 qemux86-64 agl-compositor[386]: [08:13:33.275] Removed black curtain from output Virtual-1
Apr 19 08:13:33 qemux86-64 agl-compositor[386]: [08:13:33.275] (background) position view 0x555ee831f8c0, x 0.000000, y 0.000000, on output Virtual-1
Apr 19 08:13:33 qemux86-64 agl-compositor[386]: [08:13:33.275] Using specified area for output Virtual-1, ignoring panels
Apr 19 08:13:33 qemux86-64 agl-compositor[386]: [08:13:33.275] Usable area: 1080x1488+0,216
Apr 19 08:13:33 qemux86-64 agl-compositor[386]: [08:13:33.482] Added surface 0x555eea70b740, app_id launcher to pending list
Apr 19 08:13:34 qemux86-64 agl-compositor[386]: [08:13:34.242] Removed surface 0x555eea70b740, app_id launcher, role NONE
Apr 19 08:13:34 qemux86-64 agl-compositor[386]: [08:13:34.756] Added surface 0x555eea6dd3b0, app_id launcher to pending list
Apr 19 08:13:35 qemux86-64 agl-compositor[386]: [08:13:35.380] Removed surface 0x555eea6dd3b0, app_id launcher, role NONE
Apr 19 08:13:35 qemux86-64 agl-compositor[386]: [08:13:35.893] Added surface 0x555eea70b740, app_id launcher to pending list
Apr 19 08:13:36 qemux86-64 agl-compositor[386]: [08:13:36.557] Removed surface 0x555eea70b740, app_id launcher, role NONE
Apr 19 08:13:37 qemux86-64 agl-compositor[386]: [08:13:37.044] Added surface 0x555eea6d8c70, app_id launcher to pending list
Apr 19 08:13:37 qemux86-64 agl-compositor[386]: [08:13:37.699] Removed surface 0x555eea6d8c70, app_id launcher, role NONE
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:ActivateApp() activating app navigation on output Virtual-1
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.705] Added surface 0x555eea6dd3b0, app_id navigation to pending list
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.948] Checking pending surface 0x555eea6dd3b0, app_id navigation
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.949] Refusing to activate surface role 1, app_id navigation, type regular
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.949] Refusing to activate surface role 1, app_id navigation, type regular
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:agl_shell_app_state() got app_state event app_id navigation,  state 0
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:agl_shell_app_state() writing to lister 0x7efd440015e0
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:OnWriteDone() got ok 1
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:OnWriteDone() done writting 1
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:ActivateApp() activating app navigation on output Virtual-1
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.949] Activating app_id navigation, type DESKTOP, on output Virtual-1
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.949] Activation completed for app_id navigation, role DESKTOP, output Virtual-1
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:agl_shell_app_state() got app_state event app_id navigation,  state 2
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:agl_shell_app_state() writing to lister 0x7efd440015e0
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:OnWriteDone() got ok 1
Apr 19 09:14:16 qemux86-64 agl-compositor[507]: gRPC:proxy:OnWriteDone() done writting 1
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.989] Added black curtain to output Virtual-1
Apr 19 09:14:16 qemux86-64 agl-compositor[386]: [09:14:16.989] Removed surface 0x555eea6aa860, app_id homescreen, role BACKGROUND
Apr 19 09:14:17 qemux86-64 agl-compositor[507]: gRPC:proxy:AppStatusState() added lister 0x7efd440016d0
Apr 19 09:14:17 qemux86-64 agl-compositor[386]: [09:14:17.779] Added surface 0x555eea6d8c70, app_id homescreen to pending list
Apr 19 09:14:18 qemux86-64 agl-compositor[386]: [09:14:18.280] Removed black curtain from output Virtual-1
Apr 19 09:14:18 qemux86-64 agl-compositor[386]: [09:14:18.280] (background) position view 0x555ee831f8c0, x 0.000000, y 0.000000, on output Virtual-1

      After a reboot I can't trigger it. I can't also trigger it if launcher is mask/disabled.

        1. journaltct.log.txt
          191 kB
        No reviews matched the request. Check your Options in the drop-down menu of this sections header.

            scottm Scott Murray
            mvlad Marius Vlad
            Votes:
            0 Vote for this issue
            Watchers:
            2 Start watching this issue

              Created:
              Updated: