search

microsoft / wslg

Enabling the Windows Subsystem for Linux to include support for Wayland and X server related scenarios
MIT License
10.14k stars 303 forks source link

WSLg is non-responsive randomly during work #991

Open speller opened 1 year ago

speller commented 1 year ago

Windows build number:

10.0.22621.1343

Your Distribution version:

22.04

Your WSL versions:

WSL version: 1.1.3.0
Kernel version: 5.15.90.1
WSLg version: 1.0.49
MSRDC version: 1.2.3770
Direct3D version: 1.608.2-61064218
DXCore version: 10.0.25131.1002-220531-1700.rs-onecore-base2-hyp
Windows version: 10.0.22621.1343

All updates are installed including wsl packages.

Steps to reproduce:

No steps.

WSL logs:

stderr.log

weston.log

[17:11:41.505] transfer write complete
[17:11:41.507] wrote fd:94 18 (chunk size 18) of 18 bytes
[17:11:41.508] transfer write complete
[17:11:48.951] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:11:48.952] Client: ClientGetAppidReq: WindowId:0x1de does not have appId, or not top level window.
[17:12:08.790] xfixes selection notify event: owner 12582947
[17:12:08.794] wrote fd:94 13 (chunk size 13) of 13 bytes
[17:12:08.794] transfer write complete
[17:12:08.797] wrote fd:94 13 (chunk size 13) of 13 bytes
[17:12:08.797] transfer write complete
[17:13:41.687] xfixes selection notify event: owner 12582947
[17:13:41.690] wrote fd:94 12 (chunk size 12) of 12 bytes
[17:13:41.690] transfer write complete
[17:13:41.693] wrote fd:94 12 (chunk size 12) of 12 bytes
[17:13:41.693] transfer write complete
[17:13:45.479] wrote fd:94 12 (chunk size 12) of 12 bytes
[17:13:45.479] transfer write complete
[17:15:42.309] set_position_from_xwayland: XWM 0, 0; geometry 32, 32; view -32, -32
[17:15:42.456] Client: ClientGetAppidReq: pid:403 appId:jetbrains-phpstorm
[17:15:57.862] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:15:57.862] Client: ClientGetAppidReq: WindowId:0x1e0 does not have appId, or not top level window.
[17:16:04.781] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:16:04.781] Client: ClientGetAppidReq: WindowId:0x1e1 does not have appId, or not top level window.
[17:16:05.722] set_position_from_xwayland: XWM 0, 0; geometry 32, 32; view -32, -32
[17:16:05.831] Client: ClientGetAppidReq: pid:403 appId:jetbrains-phpstorm
[17:16:06.790] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:16:06.790] Client: ClientGetAppidReq: WindowId:0x1e3 does not have appId, or not top level window.
[17:16:07.517] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:16:07.517] Client: ClientGetAppidReq: WindowId:0x1e4 does not have appId, or not top level window.
[17:16:52.293] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:16:52.293] Client: ClientGetAppidReq: WindowId:0x1e5 does not have appId, or not top level window.
[17:17:24.677] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:17:24.677] Client: ClientGetAppidReq: WindowId:0x1e6 does not have appId, or not top level window.
[17:17:25.408] app_list_monitor_thread: readlink failed /proc/403/exe:No such file or directory
[17:17:25.409] Client: ClientGetAppidReq: WindowId:0x1e7 does not have appId, or not top level window.
[17:17:26.792] set_position_from_xwayland: XWM 0, 0; geometry 32, 32; view -32, -32
[17:17:26.838] Client: ClientGetAppidReq: pid:403 appId:jetbrains-phpstorm

WSL dumps:

No dumps in the wslg/dumps dir.

Expected behavior:

No response

Actual behavior:

I'm just working normally and at some random moment, all WSLg windows stop responding. I can not click, move, minimize them.

Shell is working fine.

hideyukn88 commented 1 year ago

@speller, thanks for reporting the issue, when it's in that state, can another app be started? thanks!

richiethom commented 1 year ago

I'm having the same problem and am unable to start another app. I can't kill Weston so I'll have to kill the whole of WSL.

WSL2+WSLG had been working flawlessly for a number of months, but this morning my machine (Windows 11) prompted me to update WSL and now I'm getting this problem.

I also installed Windows 11 KB5022913 today.

Versions:

WSLg ( x86_64 ): 1.0.49+Branch.main.Sha.32eaeea0d48ad0f6dcdc8cae3e2a9218358f300a
Mariner: VERSION="2.0.20221010"
DirectX-Headers:
mesa:
pulseaudio: 2f0f0b8c3872780f15e275fc12899f4564f01bd5
FreeRDP: c574044a10003e50453acb4cf42801c5833fb572
weston: 3ff4250b28aefbcfefdd869cb997d0591c06b6d8
speller commented 1 year ago

@hideyukn88 No, no other gui apps can be started

hideyukn88 commented 1 year ago

@speller, @richiethom, thanks for checking, there is similar issue reported previously, and we need core dump of weston to investigate further, when it happens please follow instructions at https://github.com/microsoft/wslg/issues/854#issuecomment-1276450446 to collect dump and share with us, thanks!

speller commented 1 year ago

@hideyukn88 Ok, next time it happen, I will create a core dump.

speller commented 1 year ago

@hideyukn88 I just faced the issue again and tried your instruction to take the core dump. But the gcore command hanged as well and didn't do anything:

root@DELL [ /mnt/c/Users/mail ]# ps -aux
wslg         9  0.2  0.4 1041928 80140 ?       Dl   10:15   0:57 /usr/bin/weston --backend=rdp-backend.so ...
root     25880  0.0  0.0   4376  3040 pts/0    S+   17:14   0:00 bash /usr/bin/gcore 9

root@DELL [ /mnt/c/Users/mail ]# ps -p 25880 -o etime
    ELAPSED
      15:58

Pressing Ctrl+C in the hung gcore doesn't work. But kill 25880 worked.

Here is some information I took from standard linux tools:

 cat /proc/9/status
Name:   weston
Umask:  0000
State:  D (disk sleep)
Tgid:   9
Ngid:   0
Pid:    9
PPid:   6
TracerPid:      25882
Uid:    1000    1000    1000    1000
Gid:    1000    1000    1000    1000
FDSize: 128
Groups: 1000
NStgid: 9
NSpid:  9
NSpgid: 0
NSsid:  0
VmPeak:  1069816 kB
VmSize:  1041928 kB
VmLck:         0 kB
VmPin:         0 kB
VmHWM:    113004 kB
VmRSS:     80060 kB
RssAnon:           11860 kB
RssFile:            4492 kB
RssShmem:          63708 kB
VmData:   162120 kB
VmStk:       132 kB
VmExe:         4 kB
VmLib:     21504 kB
VmPTE:       440 kB
VmSwap:    11484 kB
HugetlbPages:          0 kB
CoreDumping:    0
THP_enabled:    1
Threads:        17
SigQ:   4/63384
SigPnd: 0000000000040000
ShdPnd: 0000000000000000
SigBlk: 0000000000014a00
SigIgn: 0000000000000000
SigCgt: 0000000100000002
CapInh: 00000000002c0000
CapPrm: 00000000002c0000
CapEff: 00000000002c0000
CapBnd: 000001ffffffffff
CapAmb: 00000000002c0000
NoNewPrivs:     0
Seccomp:        0
Seccomp_filters:        0
Speculation_Store_Bypass:       thread vulnerable
SpeculationIndirectBranch:      conditional enabled
Cpus_allowed:   3f
Cpus_allowed_list:      0-5
Mems_allowed:   1
Mems_allowed_list:      0
voluntary_ctxt_switches:        131954
nonvoluntary_ctxt_switches:     7986

/proc/9/task/
10/ 57/ 58/ 59/ 60/ 61/ 62/ 67/ 68/ 69/ 70/ 71/ 72/ 73/ 74/ 77/ 9/

 cat /proc/9/task/10/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/57/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/58/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/59/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/60/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/61/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/62/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/67/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/68/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/69/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/70/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/71/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/72/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/73/stack
[<0>] __skb_wait_for_more_packets+0x114/0x180
[<0>] __skb_recv_datagram+0x69/0xc0
[<0>] skb_recv_datagram+0x46/0x70
[<0>] unix_accept+0x93/0x170
[<0>] do_accept+0xf7/0x170
[<0>] __sys_accept4_file+0x51/0xa0
[<0>] __sys_accept4+0x54/0xa0
[<0>] __x64_sys_accept+0x18/0x20
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/74/stack
[<0>] do_sys_poll+0x421/0x5a0
[<0>] __x64_sys_poll+0x37/0x140
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/77/stack
[<0>] unix_stream_read_generic+0x60e/0xb40
[<0>] unix_stream_recvmsg+0x92/0xa0
[<0>] sock_read_iter+0x123/0x130
[<0>] new_sync_read+0x192/0x1b0
[<0>] vfs_read+0xf4/0x190
[<0>] ksys_read+0xab/0xe0
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb
root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/9/stack
[<0>] request_wait_answer+0xaf/0x210
[<0>] fuse_simple_request+0x19e/0x2b0
[<0>] fuse_do_getattr+0xd5/0x2f0
[<0>] fuse_permission+0x11a/0x180
[<0>] inode_permission+0x141/0x1d0
[<0>] link_path_walk.part.0+0x285/0x3a0
[<0>] path_openat+0xb5/0x1090
[<0>] do_filp_open+0xb2/0x120
[<0>] do_sys_openat2+0x24a/0x320
[<0>] do_sys_open+0x44/0x80
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb

The command kill -9 9 does nothing, the process still exists.

By googling, I understood the D state is when the process is waiting for IO. Is it possible to setup some timeouts to prevent the process from hanging infinitely?

The ls -al /proc/9/fd command also hangs. Same for lsof -p 9. Both go to the D state.

At the same time, strace ls -al /proc/9/fd exits successfully and the output is the following:

# strace ls -al /proc/9/fd
execve("/usr/bin/ls", ["ls", "-al", "/proc/9/fd"], 0x7ffe630a7f50 /* 31 vars */) = 0
brk(NULL)                               = 0x5625f96fb000
arch_prctl(0x3001 /* ARCH_??? */, 0x7ffcb8c91a90) = -1 EINVAL (Invalid argument)
mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fd4853eb000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3
newfstatat(3, "", {st_mode=S_IFREG|0644, st_size=16639, ...}, AT_EMPTY_PATH) = 0
mmap(NULL, 16639, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7fd4853e6000
close(3)                                = 0
openat(AT_FDCWD, "/lib/libcap.so.2", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0000v\0\0\0\0\0\0"..., 832) = 832
pread64(3, "\4\0\0\0 \0\0\0\5\0\0\0GNU\0\1\0\1\300\4\0\0\0\t\0\0\0\0\0\0\0"..., 48, 792) = 48
pread64(3, "\4\0\0\0\24\0\0\0\3\0\0\0GNU\0\266\312\321wR\207Q\331\244q5\204\206\312\6\224"..., 180, 840) = 180
newfstatat(3, "", {st_mode=S_IFREG|0755, st_size=44832, ...}, AT_EMPTY_PATH) = 0
mmap(NULL, 45120, PROT_READ, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fd4853da000
mmap(0x7fd4853dd000, 20480, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x7fd4853dd000
mmap(0x7fd4853e2000, 8192, PROT_READ, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x8000) = 0x7fd4853e2000
mmap(0x7fd4853e4000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x9000) = 0x7fd4853e4000
close(3)                                = 0
openat(AT_FDCWD, "/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@\347\2\0\0\0\0\0"..., 832) = 832
pread64(3, "\6\0\0\0\4\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0"..., 784, 64) = 784
pread64(3, "\4\0\0\0@\0\0\0\5\0\0\0GNU\0\2\0\0\300\4\0\0\0\3\0\0\0\0\0\0\0"..., 80, 848) = 80
pread64(3, "\4\0\0\0\24\0\0\0\3\0\0\0GNU\0\315\35\266\321\2125\350$\345\204\v\353A\330\235\t"..., 356, 928) = 356
newfstatat(3, "", {st_mode=S_IFREG|0755, st_size=2358784, ...}, AT_EMPTY_PATH) = 0
pread64(3, "\6\0\0\0\4\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0"..., 784, 64) = 784
mmap(NULL, 2103952, PROT_READ, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fd4851d8000
mprotect(0x7fd485205000, 1843200, PROT_NONE) = 0
mmap(0x7fd485205000, 1490944, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2d000) = 0x7fd485205000
mmap(0x7fd485371000, 348160, PROT_READ, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x199000) = 0x7fd485371000
mmap(0x7fd4853c7000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1ee000) = 0x7fd4853c7000
mmap(0x7fd4853cd000, 51856, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fd4853cd000
close(3)                                = 0
mmap(NULL, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fd4851d5000
arch_prctl(ARCH_SET_FS, 0x7fd4851d5700) = 0
set_tid_address(0x7fd4851d59d0)         = 26397
set_robust_list(0x7fd4851d59e0, 24)     = 0
rseq(0x7fd4851d60a0, 0x20, 0, 0x53053053) = 0
mprotect(0x7fd4853c7000, 12288, PROT_READ) = 0
mprotect(0x7fd4853e4000, 4096, PROT_READ) = 0
mprotect(0x5625f7778000, 8192, PROT_READ) = 0
mprotect(0x7fd485422000, 8192, PROT_READ) = 0
prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0
munmap(0x7fd4853e6000, 16639)           = 0
prctl(PR_CAPBSET_READ, CAP_MAC_OVERRIDE) = 1
prctl(PR_CAPBSET_READ, 0x30 /* CAP_??? */) = -1 EINVAL (Invalid argument)
prctl(PR_CAPBSET_READ, CAP_CHECKPOINT_RESTORE) = 1
prctl(PR_CAPBSET_READ, 0x2c /* CAP_??? */) = -1 EINVAL (Invalid argument)
prctl(PR_CAPBSET_READ, 0x2a /* CAP_??? */) = -1 EINVAL (Invalid argument)
prctl(PR_CAPBSET_READ, 0x29 /* CAP_??? */) = -1 EINVAL (Invalid argument)
brk(NULL)                               = 0x5625f96fb000
brk(0x5625f971c000)                     = 0x5625f971c000
ioctl(1, TCGETS, {B38400 opost isig icanon echo ...}) = 0
ioctl(1, TIOCGWINSZ, {ws_row=50, ws_col=150, ws_xpixel=0, ws_ypixel=0}) = 0
statx(AT_FDCWD, "/proc/9/fd", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFDIR|0500, stx_size=0, ...}) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
newfstatat(AT_FDCWD, "/etc/nsswitch.conf", {st_mode=S_IFREG|0644, st_size=199, ...}, 0) = 0
newfstatat(AT_FDCWD, "/", {st_mode=S_IFDIR|0755, st_size=200, ...}, 0) = 0
openat(AT_FDCWD, "/etc/nsswitch.conf", O_RDONLY|O_CLOEXEC) = 3
newfstatat(3, "", {st_mode=S_IFREG|0644, st_size=199, ...}, AT_EMPTY_PATH) = 0
read(3, "#       Begin /etc/nsswitch.conf"..., 4096) = 199
read(3, "", 4096)                       = 0
newfstatat(3, "", {st_mode=S_IFREG|0644, st_size=199, ...}, AT_EMPTY_PATH) = 0
close(3)                                = 0
openat(AT_FDCWD, "/etc/passwd", O_RDONLY|O_CLOEXEC) = 3
newfstatat(3, "", {st_mode=S_IFREG|0644, st_size=775, ...}, AT_EMPTY_PATH) = 0
lseek(3, 0, SEEK_SET)                   = 0
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 775
close(3)                                = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
newfstatat(AT_FDCWD, "/etc/nsswitch.conf", {st_mode=S_IFREG|0644, st_size=199, ...}, 0) = 0
openat(AT_FDCWD, "/etc/group", O_RDONLY|O_CLOEXEC) = 3
newfstatat(3, "", {st_mode=S_IFREG|0644, st_size=551, ...}, AT_EMPTY_PATH) = 0
lseek(3, 0, SEEK_SET)                   = 0
read(3, "root:x:0:\nbin:x:1:daemon\nsys:x:2"..., 4096) = 551
close(3)                                = 0
openat(AT_FDCWD, "/proc/9/fd", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3
newfstatat(3, "", {st_mode=S_IFDIR|0500, st_size=0, ...}, AT_EMPTY_PATH) = 0
getdents64(3, 0x5625f9702110 /* 91 entries */, 32768) = 2184
statx(AT_FDCWD, "/proc/9/fd/.", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFDIR|0500, stx_size=0, ...}) = 0
statx(AT_FDCWD, "/proc/9/fd/..", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFDIR|0555, stx_size=0, ...}) = 0
statx(AT_FDCWD, "/proc/9/fd/0", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/0", "socket:[21633]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/1", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/1", "/dev/null", 65) = 9
statx(AT_FDCWD, "/proc/9/fd/2", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/2", "/mnt/wslg/stderr.log", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/3", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/3", "socket:[19581]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/4", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/4", "socket:[19584]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/5", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0300, stx_size=64, ...}) = 0
readlink("/proc/9/fd/5", "/mnt/wslg/weston.log", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/6", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/6", "anon_inode:[eventpoll]", 65) = 22
statx(AT_FDCWD, "/proc/9/fd/7", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/7", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/8", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/8", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/9", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/9", "anon_inode:[signalfd]", 65) = 21
statx(AT_FDCWD, "/proc/9/fd/10", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/10", "anon_inode:[signalfd]", 65) = 21
statx(AT_FDCWD, "/proc/9/fd/11", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/11", "anon_inode:[signalfd]", 65) = 21
statx(AT_FDCWD, "/proc/9/fd/12", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/12", "anon_inode:[timerfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/13", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/13", "/mnt/wslg/wlog.log", 65) = 18
statx(AT_FDCWD, "/proc/9/fd/14", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/14", "socket:[19581]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/15", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/15", "/mnt/wslg/runtime-dir/wayland-0."..., 65) = 36
statx(AT_FDCWD, "/proc/9/fd/16", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/16", "socket:[21583]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/17", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/17", "socket:[21583]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/18", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/18", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/19", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/19", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/20", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/20", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/21", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/21", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/22", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/22", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/23", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/23", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/24", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/24", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/25", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0500, stx_size=64, ...}) = 0
readlink("/proc/9/fd/25", "anon_inode:inotify", 65) = 18
statx(AT_FDCWD, "/proc/9/fd/26", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0500, stx_size=64, ...}) = 0
readlink("/proc/9/fd/26", "mnt:[4026532379]", 65) = 16
statx(AT_FDCWD, "/proc/9/fd/27", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0500, stx_size=64, ...}) = 0
readlink("/proc/9/fd/27", "mnt:[4026532392]", 65) = 16
statx(AT_FDCWD, "/proc/9/fd/28", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0500, stx_size=64, ...}) = 0
readlink("/proc/9/fd/28", "anon_inode:inotify", 65) = 18
statx(AT_FDCWD, "/proc/9/fd/29", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/29", "socket:[21633]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/30", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/30", "socket:[21635]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/31", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/31", "socket:[21584]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/32", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/32", "socket:[21635]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/33", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/33", "socket:[21713]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/34", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/34", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/35", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/35", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/36", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/36", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/37", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/37", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/38", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/38", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/39", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/39", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/40", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/40", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/41", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/41", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/42", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/42", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/43", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/43", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/44", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/44", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/45", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/45", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/46", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/46", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/47", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/47", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/48", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/48", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/49", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/49", "socket:[21713]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/50", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/50", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/51", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/51", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/52", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/52", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/53", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/53", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/54", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/54", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/55", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/55", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/56", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/56", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/57", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/57", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/58", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/58", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/59", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/59", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/60", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/60", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/61", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/61", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/62", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/62", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/63", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/63", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/64", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/64", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/65", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/65", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/66", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/66", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/67", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/67", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/68", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/68", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/69", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/69", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/70", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/70", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/71", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/71", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/72", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/72", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/73", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/73", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/74", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/74", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/75", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/75", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/76", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/76", "socket:[19646]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/78", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/78", "/mnt/shared_memory/{239172a8-d28"..., 65) = 57
statx(AT_FDCWD, "/proc/9/fd/79", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/79", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/80", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/80", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/81", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/81", "anon_inode:[eventfd]", 65) = 20
statx(AT_FDCWD, "/proc/9/fd/82", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/82", "socket:[21718]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/83", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/83", "socket:[20658]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/84", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/84", "socket:[24529]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/85", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/85", "socket:[24529]", 65) = 14
statx(AT_FDCWD, "/proc/9/fd/86", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/86", "/mnt/shared_memory/{30db8068-f5c"..., 65) = 57
statx(AT_FDCWD, "/proc/9/fd/87", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/87", "/mnt/shared_memory/{823f11ad-683"..., 65) = 57
statx(AT_FDCWD, "/proc/9/fd/88", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0700, stx_size=64, ...}) = 0
readlink("/proc/9/fd/88", "/memfd:weston-shared (deleted)", 65) = 30
statx(AT_FDCWD, "/proc/9/fd/89", AT_STATX_SYNC_AS_STAT|AT_SYMLINK_NOFOLLOW, STATX_MODE|STATX_NLINK|STATX_UID|STATX_GID|STATX_MTIME|STATX_SIZE, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFLNK|0300, stx_size=64, ...}) = 0
readlink("/proc/9/fd/89", "pipe:[118113]", 65) = 13
getdents64(3, 0x5625f9702110 /* 0 entries */, 32768) = 0
close(3)                                = 0
newfstatat(1, "", {st_mode=S_IFCHR|0620, st_rdev=makedev(0x88, 0x2), ...}, AT_EMPTY_PATH) = 0
write(1, "total 0\n", 8total 0
)                = 8
openat(AT_FDCWD, "/etc/localtime", O_RDONLY|O_CLOEXEC) = 3
newfstatat(3, "", {st_mode=S_IFREG|0644, st_size=309, ...}, AT_EMPTY_PATH) = 0
newfstatat(3, "", {st_mode=S_IFREG|0644, st_size=309, ...}, AT_EMPTY_PATH) = 0
read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\4\0\0\0\4\0\0\0\0"..., 4096) = 309
lseek(3, -176, SEEK_CUR)                = 133
read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\4\0\0\0\4\0\0\0\0"..., 4096) = 176
close(3)                                = 0
write(1, "dr-x------ 2 wslg wslg  0 Mar  4"..., 41dr-x------ 2 wslg wslg  0 Mar  4 17:40 .
) = 41
write(1, "dr-xr-xr-x 9 wslg wslg  0 Mar  3"..., 42dr-xr-xr-x 9 wslg wslg  0 Mar  3 14:27 ..
) = 42
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 61lrwx------ 1 wslg wslg 64 Mar  4 18:10 0 -> 'socket:[21633]'
) = 61
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 54lrwx------ 1 wslg wslg 64 Mar  4 18:10 1 -> /dev/null
) = 54
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 69lrwx------ 1 wslg wslg 64 Mar  4 18:10 10 -> 'anon_inode:[signalfd]'
) = 69
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 69lrwx------ 1 wslg wslg 64 Mar  4 18:10 11 -> 'anon_inode:[signalfd]'
) = 69
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 12 -> 'anon_inode:[timerfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 64lrwx------ 1 wslg wslg 64 Mar  4 18:10 13 -> /mnt/wslg/wlog.log
) = 64
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 14 -> 'socket:[19581]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 82lrwx------ 1 wslg wslg 64 Mar  4 18:10 15 -> /mnt/wslg/runtime-dir/wayland-0.lock
) = 82
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 16 -> 'socket:[21583]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 17 -> 'socket:[21583]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 18 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 19 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 65lrwx------ 1 wslg wslg 64 Mar  4 18:10 2 -> /mnt/wslg/stderr.log
) = 65
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 20 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 21 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 22 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 23 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 24 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lr-x------ 1 wslg wslg 64 Mar  4"..., 64lr-x------ 1 wslg wslg 64 Mar  4 18:10 25 -> anon_inode:inotify
) = 64
write(1, "lr-x------ 1 wslg wslg 64 Mar  4"..., 64lr-x------ 1 wslg wslg 64 Mar  4 18:10 26 -> 'mnt:[4026532379]'
) = 64
write(1, "lr-x------ 1 wslg wslg 64 Mar  4"..., 64lr-x------ 1 wslg wslg 64 Mar  4 18:10 27 -> 'mnt:[4026532392]'
) = 64
write(1, "lr-x------ 1 wslg wslg 64 Mar  4"..., 64lr-x------ 1 wslg wslg 64 Mar  4 18:10 28 -> anon_inode:inotify
) = 64
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 29 -> 'socket:[21633]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 61lrwx------ 1 wslg wslg 64 Mar  4 18:10 3 -> 'socket:[19581]'
) = 61
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 30 -> 'socket:[21635]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 31 -> 'socket:[21584]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 32 -> 'socket:[21635]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 33 -> 'socket:[21713]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 34 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 35 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 36 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 37 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 38 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 39 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 61lrwx------ 1 wslg wslg 64 Mar  4 18:10 4 -> 'socket:[19584]'
) = 61
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 40 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 41 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 42 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 43 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 44 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 45 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 46 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 47 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 48 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 49 -> 'socket:[21713]'
) = 62
write(1, "l-wx------ 1 wslg wslg 64 Mar  4"..., 65l-wx------ 1 wslg wslg 64 Mar  4 18:10 5 -> /mnt/wslg/weston.log
) = 65
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 50 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 51 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 52 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 53 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 54 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 55 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 56 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 57 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 58 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 59 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 69lrwx------ 1 wslg wslg 64 Mar  4 18:10 6 -> 'anon_inode:[eventpoll]'
) = 69
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 60 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 61 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 62 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 63 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 64 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 65 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 66 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 67 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 68 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 69 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 67lrwx------ 1 wslg wslg 64 Mar  4 18:10 7 -> 'anon_inode:[eventfd]'
) = 67
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 70 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 71 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 72 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 73 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 74 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 75 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 76 -> 'socket:[19646]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 103lrwx------ 1 wslg wslg 64 Mar  4 18:10 78 -> /mnt/shared_memory/{239172a8-d288-4300-aca6-4e1acc3981dc}
) = 103
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 79 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 67lrwx------ 1 wslg wslg 64 Mar  4 18:10 8 -> 'anon_inode:[eventfd]'
) = 67
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 80 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 81 -> 'anon_inode:[eventfd]'
) = 68
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 82 -> 'socket:[21718]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 83 -> 'socket:[20658]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 84 -> 'socket:[24529]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 62lrwx------ 1 wslg wslg 64 Mar  4 18:10 85 -> 'socket:[24529]'
) = 62
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 103lrwx------ 1 wslg wslg 64 Mar  4 18:10 86 -> /mnt/shared_memory/{30db8068-f5c8-4825-907e-eabeb7bc6658}
) = 103
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 103lrwx------ 1 wslg wslg 64 Mar  4 18:10 87 -> /mnt/shared_memory/{823f11ad-6834-4f1b-a2fd-fe768a9d8f29}
) = 103
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 78lrwx------ 1 wslg wslg 64 Mar  4 18:10 88 -> '/memfd:weston-shared (deleted)'
) = 78
write(1, "l-wx------ 1 wslg wslg 64 Mar  4"..., 61l-wx------ 1 wslg wslg 64 Mar  4 18:10 89 -> 'pipe:[118113]'
) = 61
write(1, "lrwx------ 1 wslg wslg 64 Mar  4"..., 68lrwx------ 1 wslg wslg 64 Mar  4 18:10 9 -> 'anon_inode:[signalfd]'
) = 68
close(1)                                = 0
close(2)                                = 0
exit_group(0)                           = ?
+++ exited with 0 +++
speller commented 1 year ago

Faced the issue for the second time and found that the weston process is not in the D state.

image

BTW, the ls /proc/9/fd command hangs and goes to the D state only on SIGKILL:

image

The weston process falls to the D state as soon as I run gcore:

image

And gcore never exits, same as previous.

Next time, will try to get thread call stacks before running gcore.

speller commented 1 year ago

When the weston process hangs, all therads' stacks are the same, except the main thread (thread 9 is main, correct?)

When in the D state, the stack is the following:

root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/9/stack
[<0>] request_wait_answer+0xaf/0x210
[<0>] fuse_simple_request+0x19e/0x2b0
[<0>] fuse_do_getattr+0xd5/0x2f0
[<0>] fuse_permission+0x11a/0x180
[<0>] inode_permission+0x141/0x1d0
[<0>] link_path_walk.part.0+0x285/0x3a0
[<0>] path_openat+0xb5/0x1090
[<0>] do_filp_open+0xb2/0x120
[<0>] do_sys_openat2+0x24a/0x320
[<0>] do_sys_open+0x44/0x80
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb

When in the S state, the stack is the following:

root@DELL [ /mnt/c/Users/mail ]# cat /proc/9/task/9/stack
[<0>] request_wait_answer+0x171/0x210
[<0>] fuse_simple_request+0x19e/0x2b0
[<0>] fuse_do_getattr+0xd5/0x2f0
[<0>] fuse_permission+0x11a/0x180
[<0>] inode_permission+0x141/0x1d0
[<0>] link_path_walk.part.0+0x285/0x3a0
[<0>] path_openat+0xb5/0x1090
[<0>] do_filp_open+0xb2/0x120
[<0>] do_sys_openat2+0x24a/0x320
[<0>] do_sys_open+0x44/0x80
[<0>] do_syscall_64+0x38/0xc0
[<0>] entry_SYSCALL_64_after_hwframe+0x61/0xcb

The only minor difference is in the top line. Not sure what does it mean. Nothing else changes.

speller commented 1 year ago

After a number of wsl shutdowns, my WSLg stopped working. Only window frames are drawn:

image

And soon after running, WSLg hangs.

Latest relevant lines in the weston.log:

[19:13:50.320] Translated workarea:(0,0)-(3840,2088) at rdp-0:(0,0)-(3840,2160)
[19:13:52.007] retry_find_icon_file: icon (preferences-desktop-font) retry count (3)
[19:13:52.008] find_icon_file: icon (preferences-desktop-font) search retry:(4) global:(2)
[19:13:52.008] retry_find_icon_file: icon (preferences-desktop-font) retry count (3)
[19:13:52.008] find_icon_file: icon (preferences-desktop-font) search retry:(4) global:(2)
[19:13:52.724] RDP Sink version (1 - 1)
[19:13:54.010] retry_find_icon_file: icon (preferences-desktop-font) retry count (4)
[19:13:54.010] find_icon_file: icon (preferences-desktop-font) search retry:(5) global:(1)
[19:13:54.010] retry_find_icon_file: icon (preferences-desktop-font) retry count (4)
[19:13:54.010] find_icon_file: icon (preferences-desktop-font) search retry:(5) global:(0)
[19:36:00.957] 

RDP clipboard_data_source_send new (0x7fdde0000dc0:published:fd 86) vs prev (0x7fdde0000c60:cancel pending:fd 85): outstanding RDP data request (client to server)

[19:36:00.957] xfixes selection notify event: owner 2097153
[19:36:00.957] our window, skipping
[19:36:00.957] xfixes selection notify event: owner 2097153
[19:36:00.957] our window, skipping
[19:39:50.119] xfixes selection notify event: owner 2097153
[19:39:50.119] our window, skipping
[19:42:29.437] xfixes selection notify event: owner 2097153
[19:42:29.437] our window, skipping
[20:40:43.421] xfixes selection notify event: owner 2097153
[20:40:43.422] our window, skipping
[20:42:05.317] xfixes selection notify event: owner 2097153
[20:42:05.317] our window, skipping
[20:42:05.318] 

RDP clipboard_data_source_send new (0x7fdde0000b00:published:fd 86) vs prev (0x7fdde0000c60:cancel pending:fd 85): outstanding RDP data request (client to server)

[20:42:05.318] xfixes selection notify event: owner 2097153
[20:42:05.318] our window, skipping
[20:50:38.697] selection request, CLIPBOARD, target TARGETS, property GDK_SELECTION
[20:50:39.574] rdp_rail_wake_handler is called on peer_ctx:0x55637eb4bdf0
[20:50:39.580] launching '/usr/libexec/weston-rdprail-shell'
[20:50:39.734] Client: ClientGetAppidReq: pid:368 appId:firefox
[20:50:39.749] !!!cursor role is added after creation - WindowId:0x1
[20:51:35.000] selection request, CLIPBOARD, target TARGETS, property GDK_SELECTION
[20:51:35.145] Client: ClientGetAppidReq: pid:660 appId:firefox
[20:51:35.145] Client: LanguageImeInfo: ProfileType: 1 (TF_PROFILETYPE_INPUTPROCESSOR)
[20:51:35.145] Client: LanguageImeInfo: LanguageID: 0x411
[20:51:35.145] Client: LanguageImeInfo: LanguageProfileCLSID: GUID_JPNIME
[20:51:35.145] Client: LanguageImeInfo: ProfileGUID: GUID_PROFILE_MSIME_JPN
[20:51:35.145] Client: LanguageImeInfo: KeyboardLayout: 0x0
[20:51:35.145] convert_rdp_keyboard_to_xkb_rule_names: matching model=pc105 layout=jp variant=(null) options=(null)
speller commented 1 year ago

It seems like the empty window issue was caused by the incorrect WSL date issue. After fixing the date back, it started working again.

Update: nope, after fixing the date, gui worked once and then stopped again. I only see window frames. I can click through these windows.

speller commented 1 year ago

I've installed a separate wsl distro ubuntu 22 and gui is working there. It seems like something broke after many shutdowns in the previous distro.

speller commented 1 year ago

I just got this issue on a new machine with a fresh WSLg installation. The weston process is hung and not crashed, so the core dump cannot be made. If I try to kill it, it goes to the D state.

What I mentioned before it hung, its performance was degrading and windows were displayed slower and slower (I was working in the PHPStorm IDE).

WSLg ( x86_64 ): 1.0.51+Branch.main.Sha.435b42ad093d8c9e785b57f2455098db2e3508c0
Mariner: VERSION="2.0.20230107"
DirectX-Headers:
mesa:
pulseaudio: 2f0f0b8c3872780f15e275fc12899f4564f01bd5
FreeRDP: c574044a10003e50453acb4cf42801c5833fb572
weston: f09791f3314de7b414bf21a46940ff684d936eaf

Last lines in the stderr.log:

Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!

Last lines in the weston.log:

[17:29:11.270] Client: ClientGetAppidReq: pid:4028 appId:jetbrains-phpstorm WindowId:0x80
[17:29:30.463] Client: ClientGetAppidReq: WindowId:0x81 does not have appId, or not top level window.
[17:29:35.260] set_position_from_xwayland: XWM 0, 0; geometry 32, 32; view -32, -32
[17:29:35.305] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:35.313] rdp_rail_notify_app_list(): rdp_peer 0x55b9f1c01430
[17:29:35.313]     inSync: 0
[17:29:35.313]     syncStart: 0
[17:29:35.313]     syncEnd: 0
[17:29:35.313]     newAppId: 0
[17:29:35.313]     deleteAppId: 0
[17:29:35.313]     deleteAppProvider: 0
[17:29:35.313]     associateWindowId: 1
[17:29:35.313]     appId: jetbrains-phpstorm
[17:29:35.313]     appGroup: (null)
[17:29:35.313]     appExecPath: (null)
[17:29:35.313]     appWorkingDir: (null)
[17:29:35.313]     appDesc: jetbrains-phpstorm
[17:29:35.313]     appIcon: (nil)
[17:29:35.313]     appProvider: (null)
[17:29:35.313]     appWindowId: 0x82
[17:29:35.313] Client: ClientGetAppidReq: pid:4028 appId:jetbrains-phpstorm WindowId:0x82
[17:29:35.322] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:35.342] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:35.361] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:35.385] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Input/output error
[17:29:35.620] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:35.828] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:36.389] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Input/output error
[17:29:37.035] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:37.485] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:37.922] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.148] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.165] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.182] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Input/output error
[17:29:38.199] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.216] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Input/output error
[17:29:38.233] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.252] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.268] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.285] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.302] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.318] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.335] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.352] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.368] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.385] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.401] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.418] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.435] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.452] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:29:38.468] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{4461146e-12a9-4cf6-8e53-11f08730ce88}" with error: Invalid argument
[17:30:17.930] Client: ClientGetAppidReq: WindowId:0x83 does not have appId, or not top level window.
[17:30:31.853] set_position_from_xwayland: XWM 1346, 452; geometry 32, 32; view 1314, 420
[17:30:31.906] rdp_rail_notify_app_list(): rdp_peer 0x55b9f1c01430
[17:30:31.906]     inSync: 0
[17:30:31.906]     syncStart: 0
[17:30:31.906]     syncEnd: 0
[17:30:31.906]     newAppId: 0
[17:30:31.906]     deleteAppId: 0
[17:30:31.906]     deleteAppProvider: 0
[17:30:31.906]     associateWindowId: 1
[17:30:31.906]     appId: jetbrains-phpstorm
[17:30:31.906]     appGroup: (null)
[17:30:31.906]     appExecPath: (null)
[17:30:31.906]     appWorkingDir: (null)
[17:30:31.906]     appDesc: jetbrains-phpstorm
[17:30:31.906]     appIcon: (nil)
[17:30:31.906]     appProvider: (null)
[17:30:31.906]     appWindowId: 0x84
[17:30:31.906] Client: ClientGetAppidReq: pid:4028 appId:jetbrains-phpstorm WindowId:0x84
[17:30:46.256] Client: ClientGetAppidReq: WindowId:0x85 does not have appId, or not top level window.
[17:30:48.624] Client: ClientGetAppidReq: WindowId:0x86 does not have appId, or not top level window.
[17:30:48.674] rdp_allocate_shared_memory: Failed to allocate 101: "/mnt/shared_memory/{988930f0-e9c7-4905-b762-6916f67529e2}" 1609728 bytes with error: Invalid argument
[17:30:48.674] Client: ClientGetAppidReq: WindowId:0x87 is not found.
[17:30:48.700] rdp_allocate_shared_memory: Failed to allocate 101: "/mnt/shared_memory/{988930f0-e9c7-4905-b762-6916f67529e2}" 1609728 bytes with error: Invalid argument
[17:30:48.718] rdp_allocate_shared_memory: Failed to allocate 101: "/mnt/shared_memory/{988930f0-e9c7-4905-b762-6916f67529e2}" 1609728 bytes with error: Invalid argument
[17:30:48.735] rdp_allocate_shared_memory: Failed to allocate 101: "/mnt/shared_memory/{988930f0-e9c7-4905-b762-6916f67529e2}" 1609728 bytes with error: Invalid argument
[17:31:18.540] set_position_from_xwayland: XWM 0, 0; geometry 32, 32; view -32, -32
[17:31:18.592] rdp_rail_notify_app_list(): rdp_peer 0x55b9f1c01430
[17:31:18.592]     inSync: 0
[17:31:18.592]     syncStart: 0
[17:31:18.592]     syncEnd: 0
[17:31:18.592]     newAppId: 0
[17:31:18.592]     deleteAppId: 0
[17:31:18.592]     deleteAppProvider: 0
[17:31:18.592]     associateWindowId: 1
[17:31:18.592]     appId: jetbrains-phpstorm
[17:31:18.592]     appGroup: (null)
[17:31:18.592]     appExecPath: (null)
[17:31:18.592]     appWorkingDir: (null)
[17:31:18.592]     appDesc: jetbrains-phpstorm
[17:31:18.592]     appIcon: (nil)
[17:31:18.592]     appProvider: (null)
[17:31:18.592]     appWindowId: 0x88
[17:31:18.592] Client: ClientGetAppidReq: pid:4028 appId:jetbrains-phpstorm WindowId:0x88
[17:31:24.376] Client: ClientGetAppidReq: WindowId:0x89 does not have appId, or not top level window.
[17:31:28.677] Client: ClientGetAppidReq: WindowId:0x8a does not have appId, or not top level window.
[17:31:32.372] Client: ClientGetAppidReq: WindowId:0x8b does not have appId, or not top level window.
[17:31:34.116] rdp_allocate_shared_memory: Failed to open "/mnt/shared_memory/{433d6f42-1517-4eb0-8680-2a7eae845152}" with error: Input/output error
[17:31:34.129] Client: ClientGetAppidReq: WindowId:0x8c does not have appId, or not top level window.
[17:31:43.948] set_position_from_xwayland: XWM 0, 0; geometry 32, 32; view -32, -32
[17:31:43.999] rdp_rail_notify_app_list(): rdp_peer 0x55b9f1c01430
[17:31:43.999]     inSync: 0
[17:31:43.999]     syncStart: 0
[17:31:43.999]     syncEnd: 0
[17:31:43.999]     newAppId: 0
[17:31:43.999]     deleteAppId: 0
[17:31:43.999]     deleteAppProvider: 0
[17:31:43.999]     associateWindowId: 1
[17:31:43.999]     appId: jetbrains-phpstorm
[17:31:43.999]     appGroup: (null)
[17:31:43.999]     appExecPath: (null)
[17:31:43.999]     appWorkingDir: (null)
[17:31:43.999]     appDesc: jetbrains-phpstorm
[17:31:43.999]     appIcon: (nil)
[17:31:43.999]     appProvider: (null)
[17:31:43.999]     appWindowId: 0x8d
[17:31:43.999] Client: ClientGetAppidReq: pid:4028 appId:jetbrains-phpstorm WindowId:0x8d
hideyukn88 commented 1 year ago

@speller, do you see any suspicious log in dmesg? thanks!

speller commented 1 year ago

@hideyukn88 it seems dmesg daemon is not running in WSL without systemd. I've turned off systemd in my WSL instance to save some resources and from what I can see dmesg.log was not updated after that. So unfortunately I can't get details from it...

speller commented 11 months ago

Just faced this issue again. Weston went to the D state. No thread dumps and can not dump the process.

WSL version: 2.0.6.0
Kernel version: 5.15.133.1-1
WSLg version: 1.0.59
MSRDC version: 1.2.4677
Direct3D version: 1.611.1-81528511
DXCore version: 10.0.25880.1000-230602-1350.main
Windows version: 10.0.22631.2506

Messages in dmesg in the system distro relevant to wsl are the following:

[    0.000000] Linux version 5.15.133.1-microsoft-standard-WSL2 (root@1c602f52c2e4) (gcc (GCC) 11.2.0, GNU ld (GNU Binutils) 2.37) #1 SMP Thu Oct 5 21:02:42 UTC 2023
[    0.000000] Command line: initrd=\initrd.img WSL_ROOT_INIT=1 panic=-1 nr_cpus=20 bonding.max_bonds=0 dummy.numdummies=0 fb_tunnels=none swiotlb=force cgroup_no_v1=all console=hvc0 debug pty.legacy_count=0
[    0.016400] Kernel command line: initrd=\initrd.img WSL_ROOT_INIT=1 panic=-1 nr_cpus=20 bonding.max_bonds=0 dummy.numdummies=0 fb_tunnels=none swiotlb=force cgroup_no_v1=all console=hvc0 debug pty.legacy_count=0
[    0.016464] Unknown kernel command line parameters "WSL_ROOT_INIT=1", will be passed to user space.
[    0.385539] usb usb1: Manufacturer: Linux 5.15.133.1-microsoft-standard-WSL2 vhci_hcd
[    0.389414] usb usb2: Manufacturer: Linux 5.15.133.1-microsoft-standard-WSL2 vhci_hcd
[    0.476942]     WSL_ROOT_INIT=1
[    4.837980] WSL (1) ERROR: ConfigApplyWindowsLibPath:2529: open /etc/ld.so.conf.d/ld.wsl.conf
[    4.863140] WSL (1) WARNING: /usr/share/zoneinfo/Asia/Tokyo not found. Is the tzdata package installed?
[    6.680234] WSL (1) ERROR: ConfigApplyWindowsLibPath:2529: open /etc/ld.so.conf.d/ld.wsl.conf
[    6.692884] WSL (1) WARNING: /usr/share/zoneinfo/Asia/Tokyo not found. Is the tzdata package installed?
[    7.579494] WSL (2) ERROR: UtilCreateProcessAndWait:663: /bin/mount failed with 2
[    7.582179] WSL (1) ERROR: UtilCreateProcessAndWait:685: /bin/mount failed with status 0xff00
[    7.584541] WSL (1) ERROR: ConfigMountFsTab:2581: Processing fstab with mount -a failed.
[    7.586845] WSL (1) ERROR: ConfigApplyWindowsLibPath:2529: open /etc/ld.so.conf.d/ld.wsl.conf
[    7.612551] WSL (1) WARNING: /usr/share/zoneinfo/Asia/Tokyo not found. Is the tzdata package installed?
[  552.635217] WSL (266) ERROR: No buffer space available @telemetry.cpp:109 (StartTelemetryAgent)

I was closing many WSLg windows at once when the issue happened.

Nothing relevant in the weston.log. Other logs has nothing at the time of the issue. It happened at 11:20

[11:20:05.666] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:05.727] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:05.770] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:05.791] selection request, CLIPBOARD, target UTF8_STRING, property XAWT_SELECTION
[11:20:05.794] read fd:107 32 (available 65536, mask 0x5)
[11:20:05.795] nothing happened, buffered the bytes
[11:20:05.795] read fd:107 0 (available 131040, mask 0x4)
[11:20:05.795] non-incr transfer read complete
[11:20:05.925] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:05.936] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:05.942] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:05.946] selection request, CLIPBOARD, target UTF8_STRING, property XAWT_SELECTION
[11:20:05.946] read fd:103 32 (available 65536, mask 0x5)
[11:20:05.946] nothing happened, buffered the bytes
[11:20:05.946] read fd:103 0 (available 131040, mask 0x4)
[11:20:05.946] non-incr transfer read complete
[11:20:06.121] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:06.131] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:06.137] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:06.140] selection request, CLIPBOARD, target UTF8_STRING, property XAWT_SELECTION
[11:20:06.140] read fd:94 32 (available 65536, mask 0x5)
[11:20:06.140] nothing happened, buffered the bytes
[11:20:06.140] read fd:94 0 (available 131040, mask 0x4)
[11:20:06.140] non-incr transfer read complete
[11:20:06.328] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:06.337] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:06.343] selection request, CLIPBOARD, target TARGETS, property XAWT_SELECTION
[11:20:06.348] selection request, CLIPBOARD, target UTF8_STRING, property XAWT_SELECTION
[11:20:06.348] read fd:94 32 (available 65536, mask 0x5)
[11:20:06.348] nothing happened, buffered the bytes
[11:20:06.348] read fd:94 0 (available 131040, mask 0x4)
[11:20:06.348] non-incr transfer read complete
speller commented 5 months ago

The issue still happens sometimes after getting false keyboard keypress triggers. WSLg sometimes repeats some keypress a lot of times. Sometimes it ends up in some number of repetitions. But sometimes the number can be huge and it can provoke hanging so that all windows get unresponsive. I can see a lot of the following lines in the stderr.log:

Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!
Key repeat discarded, Wayland compositor doesn't seem to be processing events fast enough!