./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor317616269 <...> Warning: Permanently added '10.128.1.78' (ECDSA) to the list of known hosts. execve("./syz-executor317616269", ["./syz-executor317616269"], 0x7ffd1a7d0cb0 /* 10 vars */) = 0 brk(NULL) = 0x555556a4e000 brk(0x555556a4ec40) = 0x555556a4ec40 arch_prctl(ARCH_SET_FS, 0x555556a4e300) = 0 uname({sysname="Linux", nodename="syzkaller", ...}) = 0 set_tid_address(0x555556a4e5d0) = 371 set_robust_list(0x555556a4e5e0, 24) = 0 rt_sigaction(SIGRTMIN, {sa_handler=0x7fb9bd426550, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7fb9bd426c20}, NULL, 8) = 0 rt_sigaction(SIGRT_1, {sa_handler=0x7fb9bd4265f0, sa_mask=[], sa_flags=SA_RESTORER|SA_RESTART|SA_SIGINFO, sa_restorer=0x7fb9bd426c20}, NULL, 8) = 0 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor317616269", 4096) = 27 brk(0x555556a6fc40) = 0x555556a6fc40 brk(0x555556a70000) = 0x555556a70000 mprotect(0x7fb9bd4e8000, 16384, PROT_READ) = 0 mmap(0x1ffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffff000 mmap(0x20000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x20000000 mmap(0x21000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x21000000 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x555556a4e5d0) = 372 ./strace-static-x86_64: Process 372 attached [pid 371] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 372] set_robust_list(0x555556a4e5e0, 24) = 0 [pid 371] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 373 [pid 371] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 373 attached [pid 372] getpid( [pid 371] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 374 [pid 371] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 374 attached [pid 373] set_robust_list(0x555556a4e5e0, 24 [pid 372] <... getpid resumed>) = 372 [pid 371] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 375 [pid 371] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 375 attached [pid 374] set_robust_list(0x555556a4e5e0, 24 [pid 373] <... set_robust_list resumed>) = 0 [pid 372] mkdir("./syzkaller.qkHFtj", 0700 [pid 371] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 376 [pid 371] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 374] <... set_robust_list resumed>) = 0 [pid 371] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 377 [pid 373] getpid(./strace-static-x86_64: Process 377 attached [pid 377] set_robust_list(0x555556a4e5e0, 24) = 0 [pid 377] getpid() = 377 [pid 377] mkdir("./syzkaller.yEnIlI", 0700 [pid 372] <... mkdir resumed>) = 0 [pid 374] getpid( [pid 373] <... getpid resumed>) = 373 [pid 372] chmod("./syzkaller.qkHFtj", 0777 [pid 374] <... getpid resumed>) = 374 [pid 373] mkdir("./syzkaller.aPU4Zm", 0700 [pid 372] <... chmod resumed>) = 0 [pid 375] set_robust_list(0x555556a4e5e0, 24 [pid 374] mkdir("./syzkaller.wqAbsu", 0700 [pid 377] <... mkdir resumed>) = 0 [pid 377] chmod("./syzkaller.yEnIlI", 0777) = 0 [pid 377] chdir("./syzkaller.yEnIlI" [pid 373] <... mkdir resumed>) = 0 [pid 377] <... chdir resumed>) = 0 [pid 377] mkdir("./0", 0777 [pid 374] <... mkdir resumed>) = 0 [pid 373] chmod("./syzkaller.aPU4Zm", 0777 [pid 372] chdir("./syzkaller.qkHFtj"./strace-static-x86_64: Process 376 attached [pid 375] <... set_robust_list resumed>) = 0 [pid 374] chmod("./syzkaller.wqAbsu", 0777 [pid 373] <... chmod resumed>) = 0 [pid 372] <... chdir resumed>) = 0 [pid 374] <... chmod resumed>) = 0 [pid 373] chdir("./syzkaller.aPU4Zm" [pid 374] chdir("./syzkaller.wqAbsu" [pid 372] mkdir("./0", 0777 [pid 377] <... mkdir resumed>) = 0 [pid 377] openat(AT_FDCWD, "/dev/loop5", O_RDWR [pid 374] <... chdir resumed>) = 0 [pid 373] <... chdir resumed>) = 0 [pid 376] set_robust_list(0x555556a4e5e0, 24 [pid 375] getpid( [pid 374] mkdir("./0", 0777 [pid 373] mkdir("./0", 0777 [pid 372] <... mkdir resumed>) = 0 [pid 377] <... openat resumed>) = 3 [pid 376] <... set_robust_list resumed>) = 0 [pid 375] <... getpid resumed>) = 375 [pid 374] <... mkdir resumed>) = 0 [pid 373] <... mkdir resumed>) = 0 [pid 372] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 374] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 373] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 372] <... openat resumed>) = 3 [pid 374] <... openat resumed>) = 3 [pid 373] <... openat resumed>) = 3 [pid 372] ioctl(3, LOOP_CLR_FD [pid 374] ioctl(3, LOOP_CLR_FD [pid 373] ioctl(3, LOOP_CLR_FD [pid 372] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 374] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 373] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 372] close(3 [pid 374] close(3 [pid 373] close(3 [pid 372] <... close resumed>) = 0 [pid 374] <... close resumed>) = 0 [pid 373] <... close resumed>) = 0 [pid 372] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 374] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 373] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 372] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 378 [pid 374] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 379 [pid 373] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 380 [pid 375] mkdir("./syzkaller.mjPd5w", 0700) = 0 [pid 375] chmod("./syzkaller.mjPd5w", 0777) = 0 [pid 375] chdir("./syzkaller.mjPd5w") = 0 [pid 375] mkdir("./0", 0777) = 0 [pid 375] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 375] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 375] close(3) = 0 [pid 375] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x555556a4e5d0) = 381 [pid 376] getpid( [pid 377] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 377] close(3) = 0 [pid 377] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 376] <... getpid resumed>) = 376 [pid 376] mkdir("./syzkaller.SLrOzD", 0700) = 0 [pid 377] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 383 [pid 376] chmod("./syzkaller.SLrOzD", 0777./strace-static-x86_64: Process 381 attached ./strace-static-x86_64: Process 380 attached ./strace-static-x86_64: Process 379 attached ./strace-static-x86_64: Process 378 attached [pid 380] set_robust_list(0x555556a4e5e0, 24 [pid 378] set_robust_list(0x555556a4e5e0, 24 [pid 381] set_robust_list(0x555556a4e5e0, 24 [pid 380] <... set_robust_list resumed>) = 0 [pid 379] set_robust_list(0x555556a4e5e0, 24 [pid 378] <... set_robust_list resumed>) = 0 [pid 381] <... set_robust_list resumed>) = 0 [pid 380] chdir("./0" [pid 379] <... set_robust_list resumed>) = 0 [pid 378] chdir("./0" [pid 381] chdir("./0" [pid 380] <... chdir resumed>) = 0 [pid 379] chdir("./0" [pid 378] <... chdir resumed>) = 0 [pid 381] <... chdir resumed>) = 0 [pid 380] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 381] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 380] <... prctl resumed>) = 0 [pid 379] <... chdir resumed>) = 0 [pid 378] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 380] setpgid(0, 0 [pid 379] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 381] <... prctl resumed>) = 0 [pid 380] <... setpgid resumed>) = 0 [pid 379] <... prctl resumed>) = 0 [pid 378] <... prctl resumed>) = 0 [pid 381] setpgid(0, 0 [pid 380] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 379] setpgid(0, 0 [pid 378] setpgid(0, 0 [pid 376] <... chmod resumed>) = 0 [pid 379] <... setpgid resumed>) = 0 [pid 376] chdir("./syzkaller.SLrOzD" [pid 379] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 378] <... setpgid resumed>) = 0 [pid 376] <... chdir resumed>) = 0 [pid 381] <... setpgid resumed>) = 0 [pid 380] <... openat resumed>) = 3 [pid 379] <... openat resumed>) = 3 [pid 378] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 376] mkdir("./0", 0777 [pid 381] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 380] write(3, "1000", 4 [pid 379] write(3, "1000", 4 [pid 378] <... openat resumed>) = 3 [pid 376] <... mkdir resumed>) = 0 [pid 381] <... openat resumed>) = 3 [pid 380] <... write resumed>) = 4 [pid 379] <... write resumed>) = 4 [pid 378] write(3, "1000", 4 [pid 376] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 381] write(3, "1000", 4 [pid 380] close(3 [pid 379] close(3 [pid 378] <... write resumed>) = 4 [pid 376] <... openat resumed>) = 3 [pid 381] <... write resumed>) = 4 [pid 380] <... close resumed>) = 0 [pid 379] <... close resumed>) = 0 [pid 378] close(3 [pid 376] ioctl(3, LOOP_CLR_FD [pid 381] close(3 [pid 380] symlink("/dev/binderfs", "./binderfs" [pid 379] symlink("/dev/binderfs", "./binderfs" [pid 378] <... close resumed>) = 0 [pid 376] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 381] <... close resumed>) = 0 [pid 376] close(3) = 0 [pid 376] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 381] symlink("/dev/binderfs", "./binderfs" [pid 380] <... symlink resumed>) = 0 [pid 379] <... symlink resumed>) = 0 [pid 378] symlink("/dev/binderfs", "./binderfs"./strace-static-x86_64: Process 384 attached [pid 381] <... symlink resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] <... symlink resumed>) = 0 [pid 376] <... clone resumed>, child_tidptr=0x555556a4e5d0) = 384 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] <... futex resumed>) = 0 [pid 379] <... futex resumed>) = 0 [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 384] set_robust_list(0x555556a4e5e0, 24 [pid 381] <... futex resumed>) = 0 [pid 380] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 379] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 378] <... futex resumed>) = 0 [pid 381] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 380] <... mmap resumed>) = 0x7fb9bd3f5000 [pid 379] <... mmap resumed>) = 0x7fb9bd3f5000 [pid 378] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 381] <... mmap resumed>) = 0x7fb9bd3f5000 [pid 380] mprotect(0x7fb9bd3f6000, 131072, PROT_READ|PROT_WRITE [pid 379] mprotect(0x7fb9bd3f6000, 131072, PROT_READ|PROT_WRITE [pid 378] <... mmap resumed>) = 0x7fb9bd3f5000 [pid 381] mprotect(0x7fb9bd3f6000, 131072, PROT_READ|PROT_WRITE [pid 380] <... mprotect resumed>) = 0 [pid 379] <... mprotect resumed>) = 0 [pid 378] mprotect(0x7fb9bd3f6000, 131072, PROT_READ|PROT_WRITE./strace-static-x86_64: Process 383 attached [pid 381] <... mprotect resumed>) = 0 [pid 378] <... mprotect resumed>) = 0 [pid 383] set_robust_list(0x555556a4e5e0, 24 [pid 379] clone(child_stack=0x7fb9bd4153f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 378] clone(child_stack=0x7fb9bd4153f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 383] <... set_robust_list resumed>) = 0 [pid 381] clone(child_stack=0x7fb9bd4153f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 383] chdir("./0" [pid 380] clone(child_stack=0x7fb9bd4153f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 383] <... chdir resumed>) = 0 [pid 383] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 383] setpgid(0, 0) = 0 [pid 381] <... clone resumed>, parent_tid=[387], tls=0x7fb9bd415700, child_tidptr=0x7fb9bd4159d0) = 387 [pid 379] <... clone resumed>, parent_tid=[386], tls=0x7fb9bd415700, child_tidptr=0x7fb9bd4159d0) = 386 [pid 378] <... clone resumed>, parent_tid=[385], tls=0x7fb9bd415700, child_tidptr=0x7fb9bd4159d0) = 385 [pid 383] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 381] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] <... clone resumed>, parent_tid=[388], tls=0x7fb9bd415700, child_tidptr=0x7fb9bd4159d0) = 388 [pid 379] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000./strace-static-x86_64: Process 388 attached ./strace-static-x86_64: Process 386 attached ./strace-static-x86_64: Process 385 attached [pid 384] <... set_robust_list resumed>) = 0 [pid 383] <... openat resumed>) = 3 [pid 381] <... futex resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 379] <... futex resumed>) = 0 [pid 378] <... futex resumed>) = 0 [pid 383] write(3, "1000", 4) = 4 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 380] <... futex resumed>) = 0 [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 388] set_robust_list(0x7fb9bd4159e0, 24 [pid 386] set_robust_list(0x7fb9bd4159e0, 24 [pid 385] set_robust_list(0x7fb9bd4159e0, 24 [pid 384] chdir("./0" [pid 383] close(3 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 383] <... close resumed>) = 0 [pid 383] symlink("/dev/binderfs", "./binderfs") = 0 [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 383] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7fb9bd3f5000 ./strace-static-x86_64: Process 387 attached [pid 383] mprotect(0x7fb9bd3f6000, 131072, PROT_READ|PROT_WRITE [pid 387] set_robust_list(0x7fb9bd4159e0, 24 [pid 383] <... mprotect resumed>) = 0 [pid 387] <... set_robust_list resumed>) = 0 [pid 383] clone(child_stack=0x7fb9bd4153f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID./strace-static-x86_64: Process 389 attached [pid 388] <... set_robust_list resumed>) = 0 [pid 387] memfd_create("syzkaller", 0 [pid 386] <... set_robust_list resumed>) = 0 [pid 385] <... set_robust_list resumed>) = 0 [pid 384] <... chdir resumed>) = 0 [pid 387] <... memfd_create resumed>) = 3 [pid 383] <... clone resumed>, parent_tid=[389], tls=0x7fb9bd415700, child_tidptr=0x7fb9bd4159d0) = 389 [pid 387] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 383] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 389] set_robust_list(0x7fb9bd4159e0, 24 [pid 388] memfd_create("syzkaller", 0 [pid 387] <... mmap resumed>) = 0x7fb9b4ff5000 [pid 386] memfd_create("syzkaller", 0 [pid 385] memfd_create("syzkaller", 0 [pid 384] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 383] <... futex resumed>) = 0 [pid 389] <... set_robust_list resumed>) = 0 [pid 388] <... memfd_create resumed>) = 3 [pid 386] <... memfd_create resumed>) = 3 [pid 385] <... memfd_create resumed>) = 3 [pid 384] <... prctl resumed>) = 0 [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 384] setpgid(0, 0 [pid 388] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 386] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 385] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 389] memfd_create("syzkaller", 0 [pid 388] <... mmap resumed>) = 0x7fb9b4ff5000 [pid 386] <... mmap resumed>) = 0x7fb9b4ff5000 [pid 385] <... mmap resumed>) = 0x7fb9b4ff5000 [pid 384] <... setpgid resumed>) = 0 [pid 384] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 384] write(3, "1000", 4) = 4 [pid 384] close(3) = 0 [pid 384] symlink("/dev/binderfs", "./binderfs") = 0 [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 384] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7fb9bd3f5000 [pid 384] mprotect(0x7fb9bd3f6000, 131072, PROT_READ|PROT_WRITE) = 0 [pid 387] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 1048576 [pid 384] clone(child_stack=0x7fb9bd4153f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 389] <... memfd_create resumed>) = 3 [pid 384] <... clone resumed>, parent_tid=[390], tls=0x7fb9bd415700, child_tidptr=0x7fb9bd4159d0) = 390 [pid 389] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 384] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 389] <... mmap resumed>) = 0x7fb9b4ff5000 [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000}./strace-static-x86_64: Process 390 attached [pid 390] set_robust_list(0x7fb9bd4159e0, 24) = 0 [pid 390] memfd_create("syzkaller", 0) = 3 [pid 390] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fb9b4ff5000 [pid 387] <... write resumed>) = 1048576 [pid 387] munmap(0x7fb9b4ff5000, 1048576) = 0 [pid 387] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 388] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 1048576 [pid 387] <... openat resumed>) = 4 [ 19.522305][ T23] audit: type=1400 audit(1670977760.999:73): avc: denied { execmem } for pid=371 comm="syz-executor317" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=process permissive=1 [ 19.533121][ T23] audit: type=1400 audit(1670977761.009:74): avc: denied { read write } for pid=377 comm="syz-executor317" name="loop5" dev="devtmpfs" ino=120 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fixed_disk_device_t tclass=blk_file permissive=1 [ 19.536812][ T23] audit: type=1400 audit(1670977761.009:75): avc: denied { open } for pid=377 comm="syz-executor317" path="/dev/loop5" dev="devtmpfs" ino=120 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fixed_disk_device_t tclass=blk_file permissive=1 [ 19.540526][ T23] audit: type=1400 audit(1670977761.009:76): avc: denied { ioctl } for pid=372 comm="syz-executor317" path="/dev/loop0" dev="devtmpfs" ino=115 ioctlcmd=0x4c01 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fixed_disk_device_t tclass=blk_file permissive=1 [pid 387] ioctl(4, LOOP_SET_FD, 3 [pid 386] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 1048576 [pid 390] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 1048576 [pid 389] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 1048576 [pid 388] <... write resumed>) = 1048576 [pid 387] <... ioctl resumed>) = 0 [pid 385] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 1048576 [pid 387] close(3) = 0 [pid 387] mkdir("./file0", 0777) = 0 [pid 387] mount("/dev/loop3", "./file0", "ext4", MS_DIRSYNC|MS_NOATIME|MS_LAZYTIME, ",errors=continue" [pid 390] <... write resumed>) = 1048576 [pid 390] munmap(0x7fb9b4ff5000, 1048576) = 0 [pid 390] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4 [pid 390] ioctl(4, LOOP_SET_FD, 3 [pid 388] munmap(0x7fb9b4ff5000, 1048576) = 0 [pid 388] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 386] <... write resumed>) = 1048576 [pid 390] <... ioctl resumed>) = 0 [pid 390] close(3) = 0 [pid 390] mkdir("./file0", 0777) = 0 [pid 390] mount("/dev/loop4", "./file0", "ext4", MS_DIRSYNC|MS_NOATIME|MS_LAZYTIME, ",errors=continue" [pid 388] <... openat resumed>) = 4 [pid 388] ioctl(4, LOOP_SET_FD, 3 [pid 386] munmap(0x7fb9b4ff5000, 1048576) = 0 [pid 385] <... write resumed>) = 1048576 [pid 386] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 385] munmap(0x7fb9b4ff5000, 1048576) = 0 [pid 385] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 388] <... ioctl resumed>) = 0 [pid 386] <... openat resumed>) = 4 [pid 389] <... write resumed>) = 1048576 [pid 389] munmap(0x7fb9b4ff5000, 1048576) = 0 [pid 389] openat(AT_FDCWD, "/dev/loop5", O_RDWR) = 4 [pid 389] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 389] close(3) = 0 [pid 389] mkdir("./file0", 0777) = 0 [pid 389] mount("/dev/loop5", "./file0", "ext4", MS_DIRSYNC|MS_NOATIME|MS_LAZYTIME, ",errors=continue" [pid 388] close(3) = 0 [pid 388] mkdir("./file0", 0777) = 0 [pid 388] mount("/dev/loop1", "./file0", "ext4", MS_DIRSYNC|MS_NOATIME|MS_LAZYTIME, ",errors=continue" [pid 386] ioctl(4, LOOP_SET_FD, 3 [pid 385] <... openat resumed>) = 4 [ 19.617197][ T23] audit: type=1400 audit(1670977761.089:77): avc: denied { mounton } for pid=381 comm="syz-executor317" path="/root/syzkaller.mjPd5w/0/file0" dev="sda1" ino=1156 scontext=root:sysadm_r:sysadm_t tcontext=root:object_r:user_home_t tclass=dir permissive=1 [ 19.655879][ T387] EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue [pid 385] ioctl(4, LOOP_SET_FD, 3 [pid 387] <... mount resumed>) = 0 [pid 385] <... ioctl resumed>) = 0 [pid 387] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 387] chdir("./file0") = 0 [pid 387] ioctl(4, LOOP_CLR_FD [pid 386] <... ioctl resumed>) = 0 [pid 386] close(3) = 0 [pid 386] mkdir("./file0", 0777) = 0 [pid 386] mount("/dev/loop2", "./file0", "ext4", MS_DIRSYNC|MS_NOATIME|MS_LAZYTIME, ",errors=continue" [pid 387] <... ioctl resumed>) = 0 [pid 385] close(3 [pid 387] close(4) = 0 [pid 385] <... close resumed>) = 0 [pid 385] mkdir("./file0", 0777) = 0 [pid 385] mount("/dev/loop0", "./file0", "ext4", MS_DIRSYNC|MS_NOATIME|MS_LAZYTIME, ",errors=continue" [pid 387] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 381] <... futex resumed>) = 0 [pid 387] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 381] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 387] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 381] <... futex resumed>) = 0 [pid 387] open("./bus", O_RDWR|O_CREAT|O_TRUNC|O_SYNC|O_LARGEFILE|O_NOFOLLOW|O_NOATIME|0x29800030, 000 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 387] <... open resumed>) = 4 [ 19.665768][ T23] audit: type=1400 audit(1670977761.149:78): avc: denied { mount } for pid=381 comm="syz-executor317" name="/" dev="loop3" ino=2 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:fs_t tclass=filesystem permissive=1 [ 19.695846][ T23] audit: type=1400 audit(1670977761.169:79): avc: denied { write } for pid=381 comm="syz-executor317" name="/" dev="loop3" ino=2 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:unlabeled_t tclass=dir permissive=1 [pid 387] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 381] <... futex resumed>) = 0 [pid 387] write(4, "\x00\x00\x00\x00\x00\x00\x00\x00\x00", 9 [pid 381] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 387] <... write resumed>) = 9 [pid 381] <... futex resumed>) = 0 [pid 387] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 387] <... futex resumed>) = 0 [pid 381] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 387] openat(AT_FDCWD, "./bus", O_RDONLY [pid 381] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 387] <... openat resumed>) = 5 [pid 381] <... futex resumed>) = 0 [pid 387] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 387] <... futex resumed>) = 0 [pid 381] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 387] open("./bus", O_RDWR [pid 381] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 387] <... open resumed>) = 6 [pid 381] <... futex resumed>) = 0 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 387] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 381] <... futex resumed>) = 0 [pid 381] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [ 19.698866][ T390] EXT4-fs (loop4): mounted filesystem without journal. Opts: ,errors=continue [ 19.717834][ T23] audit: type=1400 audit(1670977761.169:80): avc: denied { add_name } for pid=381 comm="syz-executor317" name="bus" scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:unlabeled_t tclass=dir permissive=1 [ 19.747818][ T23] audit: type=1400 audit(1670977761.169:81): avc: denied { create } for pid=381 comm="syz-executor317" name="bus" scontext=root:sysadm_r:sysadm_t tcontext=root:object_r:unlabeled_t tclass=file permissive=1 [pid 387] mmap(0x20000000, 6291456, PROT_WRITE|PROT_EXEC|PROT_SEM|0x7ffff0, MAP_SHARED|MAP_FIXED|MAP_LOCKED|1< [pid 390] <... mount resumed>) = 0 [pid 387] <... mmap resumed>) = 0x20000000 [pid 381] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 381] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 381] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7fb9b50d4000 [pid 381] mprotect(0x7fb9b50d5000, 131072, PROT_READ|PROT_WRITE) = 0 [pid 381] clone(child_stack=0x7fb9b50f43f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tid=[412], tls=0x7fb9b50f4700, child_tidptr=0x7fb9b50f49d0) = 412 [pid 381] futex(0x7fb9bd4ee7b8, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 381] futex(0x7fb9bd4ee7bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000}./strace-static-x86_64: Process 412 attached [pid 412] set_robust_list(0x7fb9b50f49e0, 24) = 0 [ 19.772690][ T386] EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue [ 19.772974][ T23] audit: type=1400 audit(1670977761.169:82): avc: denied { read write open } for pid=381 comm="syz-executor317" path="/root/syzkaller.mjPd5w/0/file0/bus" dev="loop3" ino=18 scontext=root:sysadm_r:sysadm_t tcontext=root:object_r:unlabeled_t tclass=file permissive=1 [ 19.782212][ T385] EXT4-fs (loop0): mounted filesystem without journal. Opts: ,errors=continue [pid 412] sendfile(4, 5, NULL, 2147483713 [pid 390] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 389] <... mount resumed>) = 0 [pid 387] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 386] <... mount resumed>) = 0 [pid 385] <... mount resumed>) = 0 [pid 390] <... openat resumed>) = 3 [pid 389] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 387] <... futex resumed>) = 0 [pid 386] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 390] chdir("./file0" [pid 389] <... openat resumed>) = 3 [pid 387] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 386] <... openat resumed>) = 3 [pid 390] <... chdir resumed>) = 0 [pid 389] chdir("./file0" [pid 386] chdir("./file0" [pid 390] ioctl(4, LOOP_CLR_FD [pid 389] <... chdir resumed>) = 0 [pid 386] <... chdir resumed>) = 0 [pid 390] <... ioctl resumed>) = 0 [pid 389] ioctl(4, LOOP_CLR_FD [pid 386] ioctl(4, LOOP_CLR_FD [pid 390] close(4 [pid 389] <... ioctl resumed>) = 0 [pid 386] <... ioctl resumed>) = 0 [pid 390] <... close resumed>) = 0 [pid 389] close(4 [pid 386] close(4 [pid 390] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 389] <... close resumed>) = 0 [pid 386] <... close resumed>) = 0 [pid 390] <... futex resumed>) = 1 [pid 389] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 386] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 384] <... futex resumed>) = 0 [pid 390] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 389] <... futex resumed>) = 1 [pid 386] <... futex resumed>) = 1 [pid 384] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 379] <... futex resumed>) = 0 [pid 390] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 389] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 386] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 384] <... futex resumed>) = 0 [pid 379] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 390] open("./bus", O_RDWR|O_CREAT|O_TRUNC|O_SYNC|O_LARGEFILE|O_NOFOLLOW|O_NOATIME|0x29800030, 000 [pid 386] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 379] <... futex resumed>) = 0 [pid 386] open("./bus", O_RDWR|O_CREAT|O_TRUNC|O_SYNC|O_LARGEFILE|O_NOFOLLOW|O_NOATIME|0x29800030, 000 [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 386] <... open resumed>) = 4 [pid 386] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 379] <... futex resumed>) = 0 [pid 386] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 379] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 386] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 379] <... futex resumed>) = 0 [pid 386] write(4, "\x00\x00\x00\x00\x00\x00\x00\x00\x00", 9 [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 386] <... write resumed>) = 9 [pid 386] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 379] <... futex resumed>) = 0 [pid 386] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 379] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 386] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 379] <... futex resumed>) = 0 [pid 386] openat(AT_FDCWD, "./bus", O_RDONLY [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 386] <... openat resumed>) = 5 [pid 386] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 379] <... futex resumed>) = 0 [pid 386] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 379] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 386] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 379] <... futex resumed>) = 0 [pid 386] open("./bus", O_RDWR [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 386] <... open resumed>) = 6 [pid 386] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 379] <... futex resumed>) = 0 [pid 386] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 379] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 386] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 379] <... futex resumed>) = 0 [pid 386] mmap(0x20000000, 6291456, PROT_WRITE|PROT_EXEC|PROT_SEM|0x7ffff0, MAP_SHARED|MAP_FIXED|MAP_LOCKED|1< [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 386] <... mmap resumed>) = 0x20000000 [pid 386] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 379] <... futex resumed>) = 0 [pid 386] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 379] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 386] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 379] <... futex resumed>) = 0 [pid 386] sendfile(4, 5, NULL, 2147483713 [pid 379] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 383] <... futex resumed>) = 0 [pid 385] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 385] chdir("./file0") = 0 [pid 385] ioctl(4, LOOP_CLR_FD) = 0 [pid 385] close(4) = 0 [pid 385] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 378] <... futex resumed>) = 0 [pid 385] open("./bus", O_RDWR|O_CREAT|O_TRUNC|O_SYNC|O_LARGEFILE|O_NOFOLLOW|O_NOATIME|0x29800030, 000 [pid 378] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 385] <... open resumed>) = 4 [pid 378] <... futex resumed>) = 0 [pid 385] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 385] <... futex resumed>) = 0 [pid 378] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 385] write(4, "\x00\x00\x00\x00\x00\x00\x00\x00\x00", 9 [pid 378] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 385] <... write resumed>) = 9 [pid 378] <... futex resumed>) = 0 [pid 385] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 385] <... futex resumed>) = 0 [pid 378] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 385] openat(AT_FDCWD, "./bus", O_RDONLY [pid 378] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 385] <... openat resumed>) = 5 [pid 378] <... futex resumed>) = 0 [pid 385] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 385] <... futex resumed>) = 0 [pid 378] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 385] open("./bus", O_RDWR [pid 378] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 385] <... open resumed>) = 6 [pid 378] <... futex resumed>) = 0 [pid 385] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 385] <... futex resumed>) = 0 [pid 378] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 385] mmap(0x20000000, 6291456, PROT_WRITE|PROT_EXEC|PROT_SEM|0x7ffff0, MAP_SHARED|MAP_FIXED|MAP_LOCKED|1< [pid 378] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 385] <... mmap resumed>) = 0x20000000 [pid 378] <... futex resumed>) = 0 [pid 385] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 385] <... futex resumed>) = 0 [pid 378] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 385] sendfile(4, 5, NULL, 2147483713 [ 19.808436][ T389] EXT4-fs (loop5): mounted filesystem without journal. Opts: ,errors=continue [ 19.824194][ T412] EXT4-fs error (device loop3): ext4_mb_generate_buddy:805: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters [ 19.836442][ T386] EXT4-fs error (device loop2): ext4_mb_generate_buddy:805: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters [ 19.846065][ T388] EXT4-fs (loop1): mounted filesystem without journal. Opts: ,errors=continue [pid 378] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 390] <... open resumed>) = 4 [pid 388] <... mount resumed>) = 0 [pid 383] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] <... futex resumed>) = 0 [pid 390] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 390] <... futex resumed>) = 1 [pid 384] <... futex resumed>) = 0 [pid 390] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 384] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 390] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 384] <... futex resumed>) = 0 [pid 390] write(4, "\x00\x00\x00\x00\x00\x00\x00\x00\x00", 9 [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 389] <... futex resumed>) = 0 [pid 388] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 383] <... futex resumed>) = 1 [pid 381] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [ 19.859969][ T385] EXT4-fs error (device loop0): ext4_mb_generate_buddy:805: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters [ 19.867427][ T412] EXT4-fs (loop3): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 19.878836][ T386] EXT4-fs (loop2): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 19.903060][ T412] EXT4-fs (loop3): This should not happen!! Data will be lost [ 19.903060][ T412] [pid 390] <... write resumed>) = 9 [pid 389] open("./bus", O_RDWR|O_CREAT|O_TRUNC|O_SYNC|O_LARGEFILE|O_NOFOLLOW|O_NOATIME|0x29800030, 000 [pid 388] <... openat resumed>) = 3 [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 381] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 388] chdir("./file0" [pid 381] <... futex resumed>) = 1 [pid 379] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 389] <... open resumed>) = 4 [pid 388] <... chdir resumed>) = 0 [pid 381] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 379] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 389] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 388] ioctl(4, LOOP_CLR_FD [pid 379] <... futex resumed>) = 0 [pid 389] <... futex resumed>) = 1 [pid 388] <... ioctl resumed>) = 0 [pid 383] <... futex resumed>) = 0 [pid 379] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 389] write(4, "\x00\x00\x00\x00\x00\x00\x00\x00\x00", 9 [pid 388] close(4 [pid 383] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 379] <... mmap resumed>) = 0x7fb9b50d4000 [pid 389] <... write resumed>) = 9 [pid 388] <... close resumed>) = 0 [pid 383] <... futex resumed>) = 0 [pid 379] mprotect(0x7fb9b50d5000, 131072, PROT_READ|PROT_WRITE [pid 389] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 388] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 379] <... mprotect resumed>) = 0 [pid 389] <... futex resumed>) = 0 [pid 388] <... futex resumed>) = 1 [pid 383] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 379] clone(child_stack=0x7fb9b50f43f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 389] openat(AT_FDCWD, "./bus", O_RDONLY [pid 388] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 384] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 383] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) ./strace-static-x86_64: Process 414 attached [pid 390] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 387] <... futex resumed>) = 0 [pid 384] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] <... futex resumed>) = 0 [pid 378] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 389] <... openat resumed>) = 5 [pid 383] <... futex resumed>) = 0 [pid 379] <... clone resumed>, parent_tid=[414], tls=0x7fb9b50f4700, child_tidptr=0x7fb9b50f49d0) = 414 [pid 389] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 379] futex(0x7fb9bd4ee7b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 389] <... futex resumed>) = 0 [pid 383] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 383] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 379] <... futex resumed>) = 0 [pid 389] open("./bus", O_RDWR [pid 379] futex(0x7fb9bd4ee7bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 389] <... open resumed>) = 6 [pid 389] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 383] <... futex resumed>) = 0 [pid 389] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 383] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 389] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 383] <... futex resumed>) = 0 [pid 389] mmap(0x20000000, 6291456, PROT_WRITE|PROT_EXEC|PROT_SEM|0x7ffff0, MAP_SHARED|MAP_FIXED|MAP_LOCKED|1< [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 389] <... mmap resumed>) = 0x20000000 [pid 389] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 383] <... futex resumed>) = 0 [pid 389] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 383] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 389] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 383] <... futex resumed>) = 0 [pid 389] sendfile(4, 5, NULL, 2147483713 [pid 383] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 414] set_robust_list(0x7fb9b50f49e0, 24 [pid 390] <... futex resumed>) = 0 [pid 387] ioctl(6, _IOC(_IOC_WRITE, 0x66, 0x29, 0x4), 0x20000040 [pid 384] <... futex resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] <... futex resumed>) = 0 [ 19.904109][ T385] EXT4-fs (loop0): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 19.913312][ T412] EXT4-fs (loop3): Total free blocks count 0 [ 19.925261][ T385] EXT4-fs (loop0): This should not happen!! Data will be lost [ 19.925261][ T385] [ 19.941189][ T385] EXT4-fs (loop0): Total free blocks count 0 [ 19.947708][ T385] EXT4-fs (loop0): Free/Dirty block details [ 19.948302][ T389] EXT4-fs error (device loop5): ext4_mb_generate_buddy:805: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters [pid 414] <... set_robust_list resumed>) = 0 [pid 390] openat(AT_FDCWD, "./bus", O_RDONLY [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 380] <... futex resumed>) = 1 [pid 378] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 388] <... futex resumed>) = 0 [pid 388] open("./bus", O_RDWR|O_CREAT|O_TRUNC|O_SYNC|O_LARGEFILE|O_NOFOLLOW|O_NOATIME|0x29800030, 000) = 4 [pid 388] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 388] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 414] ioctl(6, _IOC(_IOC_WRITE, 0x66, 0x29, 0x4), 0x20000040 [pid 390] <... openat resumed>) = 5 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 378] <... mmap resumed>) = 0x7fb9b50d4000 [pid 381] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 379] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 390] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 378] mprotect(0x7fb9b50d5000, 131072, PROT_READ|PROT_WRITE [pid 390] <... futex resumed>) = 1 [pid 385] <... sendfile resumed>) = 63 [pid 384] <... futex resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] <... mprotect resumed>) = 0 [ 19.953989][ T385] EXT4-fs (loop0): free_blocks=2415919104 [ 19.973095][ T412] EXT4-fs (loop3): Free/Dirty block details [ 19.974736][ T385] EXT4-fs (loop0): dirty_blocks=16 [ 19.982318][ T386] EXT4-fs (loop2): This should not happen!! Data will be lost [ 19.982318][ T386] [ 19.985812][ T385] EXT4-fs (loop0): Block reservation details [ 19.999880][ T412] EXT4-fs (loop3): free_blocks=2415919104 [ 20.001202][ T385] EXT4-fs (loop0): i_reserved_data_blocks=1 [ 20.007483][ T412] EXT4-fs (loop3): dirty_blocks=16 [pid 390] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 385] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 384] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 383] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 380] <... futex resumed>) = 1 [pid 378] clone(child_stack=0x7fb9b50f43f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 388] <... futex resumed>) = 0 [pid 388] write(4, "\x00\x00\x00\x00\x00\x00\x00\x00\x00", 9) = 9 [pid 388] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 388] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 383] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 383] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7fb9b50d4000 [pid 383] mprotect(0x7fb9b50d5000, 131072, PROT_READ|PROT_WRITE) = 0 [pid 383] clone(child_stack=0x7fb9b50f43f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tid=[415], tls=0x7fb9b50f4700, child_tidptr=0x7fb9b50f49d0) = 415 [pid 390] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 385] <... futex resumed>) = 0 [pid 384] <... futex resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 383] futex(0x7fb9bd4ee7b8, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 383] futex(0x7fb9bd4ee7bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000}./strace-static-x86_64: Process 415 attached [pid 415] set_robust_list(0x7fb9b50f49e0, 24) = 0 [pid 415] ioctl(6, _IOC(_IOC_WRITE, 0x66, 0x29, 0x4), 0x20000040./strace-static-x86_64: Process 416 attached [pid 416] set_robust_list(0x7fb9b50f49e0, 24) = 0 [pid 416] futex(0x7fb9bd4ee7b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 390] open("./bus", O_RDWR [pid 385] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 380] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 378] <... clone resumed>, parent_tid=[416], tls=0x7fb9b50f4700, child_tidptr=0x7fb9b50f49d0) = 416 [ 20.012728][ T389] EXT4-fs (loop5): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.018702][ T412] EXT4-fs (loop3): Block reservation details [ 20.030104][ T389] EXT4-fs (loop5): This should not happen!! Data will be lost [ 20.030104][ T389] [ 20.039868][ T386] EXT4-fs (loop2): Total free blocks count 0 [ 20.046088][ T389] EXT4-fs (loop5): Total free blocks count 0 [ 20.054547][ T412] EXT4-fs (loop3): i_reserved_data_blocks=1 [ 20.057829][ T389] EXT4-fs (loop5): Free/Dirty block details [pid 390] <... open resumed>) = 6 [pid 380] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] futex(0x7fb9bd4ee7b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 412] <... sendfile resumed>) = 63 [pid 412] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 412] futex(0x7fb9bd4ee7b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 390] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 388] <... futex resumed>) = 0 [pid 387] <... ioctl resumed>) = 0 [pid 380] <... futex resumed>) = 1 [pid 378] <... futex resumed>) = 1 [pid 416] <... futex resumed>) = 0 [pid 416] ioctl(6, _IOC(_IOC_WRITE, 0x66, 0x29, 0x4), 0x20000040) = 0 [pid 416] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 416] futex(0x7fb9bd4ee7b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 390] <... futex resumed>) = 1 [pid 388] openat(AT_FDCWD, "./bus", O_RDONLY [pid 387] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 384] <... futex resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 378] futex(0x7fb9bd4ee7bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 381] exit_group(0 [pid 412] <... futex resumed>) = ? [pid 412] +++ exited with 0 +++ [pid 381] <... exit_group resumed>) = ? [pid 390] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 388] <... openat resumed>) = 5 [pid 387] <... futex resumed>) = ? [pid 384] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 378] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 383] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 390] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 389] <... sendfile resumed>) = 63 [pid 388] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 387] +++ exited with 0 +++ [pid 384] <... futex resumed>) = 0 [pid 381] +++ exited with 0 +++ [pid 378] exit_group(0 [pid 390] mmap(0x20000000, 6291456, PROT_WRITE|PROT_EXEC|PROT_SEM|0x7ffff0, MAP_SHARED|MAP_FIXED|MAP_LOCKED|1< [pid 388] <... futex resumed>) = 1 [pid 385] <... futex resumed>) = ? [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 380] <... futex resumed>) = 0 [pid 378] <... exit_group resumed>) = ? [pid 375] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=381, si_uid=0, si_status=0, si_utime=0, si_stime=16} --- [pid 390] <... mmap resumed>) = 0x20000000 [pid 388] open("./bus", O_RDWR [pid 385] +++ exited with 0 +++ [pid 380] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 390] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 388] <... open resumed>) = 6 [pid 380] <... futex resumed>) = 0 [pid 390] <... futex resumed>) = 1 [pid 388] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 384] <... futex resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 375] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 390] sendfile(4, 5, NULL, 2147483713 [pid 388] <... futex resumed>) = 0 [pid 384] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 375] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 388] mmap(0x20000000, 6291456, PROT_WRITE|PROT_EXEC|PROT_SEM|0x7ffff0, MAP_SHARED|MAP_FIXED|MAP_LOCKED|1< [pid 384] <... futex resumed>) = 0 [pid 380] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 375] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 388] <... mmap resumed>) = 0x20000000 [pid 384] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 380] <... futex resumed>) = 0 [pid 375] <... openat resumed>) = 3 [pid 388] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 375] fstat(3, [pid 388] <... futex resumed>) = 0 [pid 380] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 375] <... fstat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 388] sendfile(4, 5, NULL, 2147483713 [pid 380] futex(0x7fb9bd4ee7a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 375] getdents64(3, [pid 380] <... futex resumed>) = 0 [pid 375] <... getdents64 resumed>0x555556a4f620 /* 4 entries */, 32768) = 112 [pid 380] futex(0x7fb9bd4ee7ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 375] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 375] lstat("./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}) = 0 [pid 375] unlink("./0/binderfs") = 0 [pid 375] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 415] <... ioctl resumed>) = 0 [pid 389] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 0 [ 20.064473][ T386] EXT4-fs (loop2): Free/Dirty block details [ 20.069414][ T389] EXT4-fs (loop5): free_blocks=2415919104 [ 20.076571][ T386] EXT4-fs (loop2): free_blocks=2415919104 [ 20.080971][ T389] EXT4-fs (loop5): dirty_blocks=16 [ 20.088309][ T386] EXT4-fs (loop2): dirty_blocks=16 [ 20.092134][ T389] EXT4-fs (loop5): Block reservation details [ 20.098475][ T386] EXT4-fs (loop2): Block reservation details [ 20.103188][ T389] EXT4-fs (loop5): i_reserved_data_blocks=1 [ 20.109907][ T386] EXT4-fs (loop2): i_reserved_data_blocks=1 [pid 389] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 414] <... ioctl resumed>) = 0 [pid 414] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 414] futex(0x7fb9bd4ee7b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 386] <... sendfile resumed>) = 63 [pid 386] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 386] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 415] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 415] futex(0x7fb9bd4ee7b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 416] <... futex resumed>) = ? [pid 416] +++ exited with 0 +++ [pid 378] +++ exited with 0 +++ [pid 383] exit_group(0 [pid 379] exit_group(0 [pid 372] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=378, si_uid=0, si_status=0, si_utime=0, si_stime=13} --- [pid 415] <... futex resumed>) = ? [pid 414] <... futex resumed>) = ? [pid 389] <... futex resumed>) = ? [pid 383] <... exit_group resumed>) = ? [pid 379] <... exit_group resumed>) = ? [pid 415] +++ exited with 0 +++ [pid 414] +++ exited with 0 +++ [pid 389] +++ exited with 0 +++ [pid 383] +++ exited with 0 +++ [pid 372] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 377] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=383, si_uid=0, si_status=0, si_utime=0, si_stime=15} --- [pid 372] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 377] restart_syscall(<... resuming interrupted clone ...> [pid 372] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 372] fstat(3, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 372] getdents64(3, 0x555556a4f620 /* 4 entries */, 32768) = 112 [pid 372] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 372] lstat("./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}) = 0 [pid 372] unlink("./0/binderfs" [pid 377] <... restart_syscall resumed>) = 0 [pid 372] <... unlink resumed>) = 0 [pid 372] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 377] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 377] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 377] fstat(3, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 377] getdents64(3, 0x555556a4f620 /* 4 entries */, 32768) = 112 [pid 377] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 377] lstat("./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}) = 0 [pid 377] unlink("./0/binderfs") = 0 [pid 377] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 386] <... futex resumed>) = ? [pid 384] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 380] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 384] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 384] <... futex resumed>) = 0 [pid 380] <... futex resumed>) = 0 [pid 384] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 380] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 384] <... mmap resumed>) = 0x7fb9b50d4000 [pid 380] <... mmap resumed>) = 0x7fb9b50d4000 [pid 384] mprotect(0x7fb9b50d5000, 131072, PROT_READ|PROT_WRITE [pid 380] mprotect(0x7fb9b50d5000, 131072, PROT_READ|PROT_WRITE [pid 384] <... mprotect resumed>) = 0 [ 20.121188][ T177] EXT4-fs (loop3): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.131901][ T390] EXT4-fs error (device loop4): ext4_mb_generate_buddy:805: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters [ 20.133416][ T177] EXT4-fs (loop3): This should not happen!! Data will be lost [ 20.133416][ T177] [ 20.148716][ T388] EXT4-fs error (device loop1): ext4_mb_generate_buddy:805: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters [pid 380] <... mprotect resumed>) = 0 [pid 384] clone(child_stack=0x7fb9b50f43f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 380] clone(child_stack=0x7fb9b50f43f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID [pid 384] <... clone resumed>, parent_tid=[418], tls=0x7fb9b50f4700, child_tidptr=0x7fb9b50f49d0) = 418 [pid 380] <... clone resumed>, parent_tid=[419], tls=0x7fb9b50f4700, child_tidptr=0x7fb9b50f49d0) = 419 [pid 384] futex(0x7fb9bd4ee7b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 380] futex(0x7fb9bd4ee7b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 384] <... futex resumed>) = 0 [pid 380] <... futex resumed>) = 0 [pid 384] futex(0x7fb9bd4ee7bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 380] futex(0x7fb9bd4ee7bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 386] +++ exited with 0 +++ [pid 379] +++ exited with 0 +++ [pid 374] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=379, si_uid=0, si_status=0, si_utime=0, si_stime=10} --- [pid 374] restart_syscall(<... resuming interrupted clone ...>./strace-static-x86_64: Process 419 attached ./strace-static-x86_64: Process 418 attached ) = 0 [ 20.158140][ T9] EXT4-fs (loop0): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.179199][ T390] EXT4-fs (loop4): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.185190][ T177] EXT4-fs (loop5): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.197018][ T390] EXT4-fs (loop4): This should not happen!! Data will be lost [ 20.197018][ T390] [pid 419] set_robust_list(0x7fb9b50f49e0, 24 [pid 418] set_robust_list(0x7fb9b50f49e0, 24 [pid 384] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 380] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 419] <... set_robust_list resumed>) = 0 [pid 418] <... set_robust_list resumed>) = 0 [pid 419] ioctl(6, _IOC(_IOC_WRITE, 0x66, 0x29, 0x4), 0x20000040 [pid 418] ioctl(6, _IOC(_IOC_WRITE, 0x66, 0x29, 0x4), 0x20000040 [ 20.209894][ T388] EXT4-fs (loop1): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.219561][ T390] EXT4-fs (loop4): Total free blocks count 0 [ 20.232000][ T9] EXT4-fs (loop0): This should not happen!! Data will be lost [ 20.232000][ T9] [ 20.238510][ T390] EXT4-fs (loop4): Free/Dirty block details [ 20.247411][ T388] EXT4-fs (loop1): This should not happen!! Data will be lost [ 20.247411][ T388] [ 20.253179][ T390] EXT4-fs (loop4): free_blocks=2415919104 [pid 374] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 374] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 374] fstat(3, [pid 390] <... sendfile resumed>) = 63 [pid 390] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 390] futex(0x7fb9bd4ee7a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 374] <... fstat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 374] getdents64(3, 0x555556a4f620 /* 4 entries */, 32768) = 112 [pid 374] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 374] lstat("./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}) = 0 [pid 374] unlink("./0/binderfs") = 0 [pid 374] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 418] <... ioctl resumed>) = 0 [pid 418] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 418] futex(0x7fb9bd4ee7b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 384] exit_group(0 [pid 418] <... futex resumed>) = ? [pid 384] <... exit_group resumed>) = ? [pid 418] +++ exited with 0 +++ [pid 390] <... futex resumed>) = ? [pid 390] +++ exited with 0 +++ [pid 384] +++ exited with 0 +++ [pid 376] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=384, si_uid=0, si_status=0, si_utime=0, si_stime=14} --- [pid 376] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 376] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 376] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 376] fstat(3, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 376] getdents64(3, 0x555556a4f620 /* 4 entries */, 32768) = 112 [pid 376] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 376] lstat("./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}) = 0 [pid 376] unlink("./0/binderfs") = 0 [ 20.262957][ T177] EXT4-fs (loop5): This should not happen!! Data will be lost [ 20.262957][ T177] [ 20.269252][ T390] EXT4-fs (loop4): dirty_blocks=16 [ 20.278661][ T388] EXT4-fs (loop1): Total free blocks count 0 [ 20.283897][ T390] EXT4-fs (loop4): Block reservation details [ 20.295528][ T388] EXT4-fs (loop1): Free/Dirty block details [ 20.296538][ T390] EXT4-fs (loop4): i_reserved_data_blocks=1 [ 20.301933][ T388] EXT4-fs (loop1): free_blocks=2415919104 [pid 376] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 375] <... umount2 resumed>) = 0 [pid 375] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 419] <... ioctl resumed>) = 0 [pid 388] <... sendfile resumed>) = 63 [pid 375] lstat("./0/file0", [pid 419] futex(0x7fb9bd4ee7bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 388] futex(0x7fb9bd4ee7ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 375] <... lstat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 419] futex(0x7fb9bd4ee7b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 388] <... futex resumed>) = 0 [pid 375] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 380] exit_group(0 [pid 375] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 375] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 375] fstat(4, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 375] getdents64(4, 0x555556a57660 /* 2 entries */, 32768) = 48 [pid 375] getdents64(4, 0x555556a57660 /* 0 entries */, 32768) = 0 [pid 375] close(4) = 0 [pid 375] rmdir("./0/file0" [pid 419] <... futex resumed>) = ? [pid 380] <... exit_group resumed>) = ? [pid 419] +++ exited with 0 +++ [pid 375] <... rmdir resumed>) = 0 [pid 375] getdents64(3, 0x555556a4f620 /* 0 entries */, 32768) = 0 [pid 375] close(3) = 0 [pid 375] rmdir("./0") = 0 [pid 375] mkdir("./1", 0777) = 0 [pid 375] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 388] +++ exited with 0 +++ [pid 380] +++ exited with 0 +++ [pid 373] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=380, si_uid=0, si_status=0, si_utime=0, si_stime=15} --- [pid 373] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 373] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 373] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 373] fstat(3, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 373] getdents64(3, 0x555556a4f620 /* 4 entries */, 32768) = 112 [pid 373] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 373] lstat("./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}) = 0 [pid 373] unlink("./0/binderfs") = 0 [ 20.313506][ T9] EXT4-fs (loop2): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.318280][ T388] EXT4-fs (loop1): dirty_blocks=16 [ 20.326159][ T9] EXT4-fs (loop2): This should not happen!! Data will be lost [ 20.326159][ T9] [ 20.331281][ T177] EXT4-fs (loop4): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.341074][ T388] EXT4-fs (loop1): Block reservation details [ 20.352703][ T177] EXT4-fs (loop4): This should not happen!! Data will be lost [ 20.352703][ T177] [ 20.360651][ T388] EXT4-fs (loop1): i_reserved_data_blocks=1 [pid 373] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 372] <... umount2 resumed>) = 0 [pid 372] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 372] lstat("./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 372] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 372] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 372] fstat(4, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 372] getdents64(4, 0x555556a57660 /* 2 entries */, 32768) = 48 [pid 372] getdents64(4, 0x555556a57660 /* 0 entries */, 32768) = 0 [pid 372] close(4) = 0 [pid 372] rmdir("./0/file0") = 0 [pid 372] getdents64(3, 0x555556a4f620 /* 0 entries */, 32768) = 0 [pid 372] close(3) = 0 [pid 372] rmdir("./0") = 0 [pid 372] mkdir("./1", 0777) = 0 [ 20.381432][ T9] EXT4-fs (loop1): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 [ 20.393678][ T9] EXT4-fs (loop1): This should not happen!! Data will be lost [ 20.393678][ T9] [pid 372] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 375] <... openat resumed>) = 3 [pid 375] ioctl(3, LOOP_CLR_FD [pid 377] <... umount2 resumed>) = 0 [pid 376] <... umount2 resumed>) = 0 [pid 374] <... umount2 resumed>) = 0 [pid 374] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 374] lstat("./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 374] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 374] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 374] fstat(4, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 374] getdents64(4, [pid 376] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 377] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 374] <... getdents64 resumed>0x555556a57660 /* 2 entries */, 32768) = 48 [pid 376] lstat("./0/file0", [pid 374] getdents64(4, [pid 376] <... lstat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 374] <... getdents64 resumed>0x555556a57660 /* 0 entries */, 32768) = 0 [pid 376] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 374] close(4 [pid 376] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 374] <... close resumed>) = 0 [pid 374] rmdir("./0/file0" [pid 376] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 376] fstat(4, {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 [pid 376] getdents64(4, [pid 375] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 373] <... umount2 resumed>) = 0 [pid 374] <... rmdir resumed>) = 0 [pid 376] <... getdents64 resumed>0x555556a57660 /* 2 entries */, 32768) = 48 [pid 376] getdents64(4, 0x555556a57660 /* 0 entries */, 32768) = 0 [pid 376] close(4) = 0 [pid 376] rmdir("./0/file0"