Extracting prog: 1m34.148388632s Minimizing prog: 10m0.351662634s Simplifying prog options: 3m20.11542003s Extracting C: 1m41.084066756s Simplifying C: 0s extracting reproducer from 1 programs testing a last program of every proc single: executing 1 programs separately with timeout 30s testing program (duration=30s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program did not crash single: failed to extract reproducer single: executing 1 programs separately with timeout 1m40s testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF single: successfully extracted reproducer found reproducer with 3 syscalls minimizing guilty program testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3 detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000), 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) program did not crash testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) close(0xffffffffffffffff) program did not crash testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): syz_clone3-close detailed listing: executing program 0: syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program did not crash testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, 0x0, 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program did not crash testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(0x0, 0x0) close(0xffffffffffffffff) program did not crash testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, 0x0, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0}, 0x58) close(0xffffffffffffffff) program did not crash extracting C reproducer testing compiled C program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close program did not crash simplifying guilty program options testing program (duration=1m40s, {Threaded:false Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program did not crash testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program did not crash testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF validation run: crashed=true testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF validation run: crashed=true testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program crashed: lost connection to test machine ignore low priority crash: lost connection to test machine validation run: crashed=false testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:4 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$random-syz_clone3-close detailed listing: executing program 0: openat$random(0xffffffffffffff9c, &(0x7f0000000000), 0x800, 0x0) syz_clone3(&(0x7f0000000100)={0x4080000, &(0x7f0000000000)=0xffffffffffffffff, 0x0, 0x0, {0x2b}, 0x0, 0x0, 0x0, 0x0, 0xfffffe21}, 0x58) close(r0) program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF validation run: crashed=true reproducing took 19m31.703864602s repro crashed as (corrupted=false): W0711 20:34:45.585525 520660 util.go:107] FATAL ERROR: waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-1-race-1": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-1-race-1": urpc method "containerManager.WaitPID" failed: EOF W0711 20:34:45.585695 520660 cli.go:319] Failure to execute command, err: 1 D0711 20:34:45.629364 1 connection.go:150] sock read failed, closing connection: EOF W0711 20:34:45.629472 518133 sandbox.go:1455] Wait RPC to container "ci-gvisor-ptrace-1-race-1" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. I0711 20:34:45.632036 1 gofer.go:444] All lisafs servers exited. I0711 20:34:45.632171 1 cli.go:310] Exiting with status: 0 D0711 20:34:45.635602 518133 container.go:906] Destroy container, cid: ci-gvisor-ptrace-1-race-1 D0711 20:34:45.635782 518133 container.go:1255] Destroying container, cid: ci-gvisor-ptrace-1-race-1 D0711 20:34:45.635819 518133 sandbox.go:2196] Destroying root container by destroying sandbox, cid: ci-gvisor-ptrace-1-race-1 D0711 20:34:45.635851 518133 sandbox.go:1526] Destroying sandbox "ci-gvisor-ptrace-1-race-1" D0711 20:34:45.635952 518133 container.go:1269] Killing gofer for container, cid: ci-gvisor-ptrace-1-race-1, PID: 518218 D0711 20:34:45.650613 518133 cgroup.go:605] Deleting cgroup "ci-gvisor-ptrace-1-race-1" D0711 20:34:45.650778 518133 cgroup.go:613] Removing cgroup controller for key="pids" path="/sys/fs/cgroup/pids/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.650908 518133 cgroup.go:613] Removing cgroup controller for key="cpuacct" path="/sys/fs/cgroup/cpuacct/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.650972 518133 cgroup.go:613] Removing cgroup controller for key="freezer" path="/sys/fs/cgroup/freezer/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651028 518133 cgroup.go:613] Removing cgroup controller for key="perf_event" path="/sys/fs/cgroup/perf_event/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651104 518133 cgroup.go:613] Removing cgroup controller for key="cpuset" path="/sys/fs/cgroup/cpuset/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651183 518133 cgroup.go:613] Removing cgroup controller for key="net_cls" path="/sys/fs/cgroup/net_cls/ci-gvisor-ptrace-1-race-1" I0711 20:34:45.651203 518133 container.go:678] Gofer process (PID=518218) reaped: exit code = -1 D0711 20:34:45.651254 518133 cgroup.go:613] Removing cgroup controller for key="net_prio" path="/sys/fs/cgroup/net_prio/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651359 518133 cgroup.go:613] Removing cgroup controller for key="devices" path="/sys/fs/cgroup/devices/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651413 518133 cgroup.go:613] Removing cgroup controller for key="rdma" path="/sys/fs/cgroup/rdma/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651530 518133 cgroup.go:613] Removing cgroup controller for key="systemd" path="/sys/fs/cgroup/systemd/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651587 518133 cgroup.go:613] Removing cgroup controller for key="blkio" path="/sys/fs/cgroup/blkio/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651642 518133 cgroup.go:613] Removing cgroup controller for key="cpu" path="/sys/fs/cgroup/cpu/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651688 518133 cgroup.go:613] Removing cgroup controller for key="hugetlb" path="/sys/fs/cgroup/hugetlb/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651737 518133 cgroup.go:613] Removing cgroup controller for key="memory" path="/sys/fs/cgroup/memory/ci-gvisor-ptrace-1-race-1" I0711 20:34:45.655612 518133 cli.go:310] Exiting with status: 9 final repro crashed as (corrupted=false): W0711 20:34:45.585525 520660 util.go:107] FATAL ERROR: waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-1-race-1": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-1-race-1": urpc method "containerManager.WaitPID" failed: EOF W0711 20:34:45.585695 520660 cli.go:319] Failure to execute command, err: 1 D0711 20:34:45.629364 1 connection.go:150] sock read failed, closing connection: EOF W0711 20:34:45.629472 518133 sandbox.go:1455] Wait RPC to container "ci-gvisor-ptrace-1-race-1" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. I0711 20:34:45.632036 1 gofer.go:444] All lisafs servers exited. I0711 20:34:45.632171 1 cli.go:310] Exiting with status: 0 D0711 20:34:45.635602 518133 container.go:906] Destroy container, cid: ci-gvisor-ptrace-1-race-1 D0711 20:34:45.635782 518133 container.go:1255] Destroying container, cid: ci-gvisor-ptrace-1-race-1 D0711 20:34:45.635819 518133 sandbox.go:2196] Destroying root container by destroying sandbox, cid: ci-gvisor-ptrace-1-race-1 D0711 20:34:45.635851 518133 sandbox.go:1526] Destroying sandbox "ci-gvisor-ptrace-1-race-1" D0711 20:34:45.635952 518133 container.go:1269] Killing gofer for container, cid: ci-gvisor-ptrace-1-race-1, PID: 518218 D0711 20:34:45.650613 518133 cgroup.go:605] Deleting cgroup "ci-gvisor-ptrace-1-race-1" D0711 20:34:45.650778 518133 cgroup.go:613] Removing cgroup controller for key="pids" path="/sys/fs/cgroup/pids/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.650908 518133 cgroup.go:613] Removing cgroup controller for key="cpuacct" path="/sys/fs/cgroup/cpuacct/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.650972 518133 cgroup.go:613] Removing cgroup controller for key="freezer" path="/sys/fs/cgroup/freezer/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651028 518133 cgroup.go:613] Removing cgroup controller for key="perf_event" path="/sys/fs/cgroup/perf_event/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651104 518133 cgroup.go:613] Removing cgroup controller for key="cpuset" path="/sys/fs/cgroup/cpuset/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651183 518133 cgroup.go:613] Removing cgroup controller for key="net_cls" path="/sys/fs/cgroup/net_cls/ci-gvisor-ptrace-1-race-1" I0711 20:34:45.651203 518133 container.go:678] Gofer process (PID=518218) reaped: exit code = -1 D0711 20:34:45.651254 518133 cgroup.go:613] Removing cgroup controller for key="net_prio" path="/sys/fs/cgroup/net_prio/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651359 518133 cgroup.go:613] Removing cgroup controller for key="devices" path="/sys/fs/cgroup/devices/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651413 518133 cgroup.go:613] Removing cgroup controller for key="rdma" path="/sys/fs/cgroup/rdma/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651530 518133 cgroup.go:613] Removing cgroup controller for key="systemd" path="/sys/fs/cgroup/systemd/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651587 518133 cgroup.go:613] Removing cgroup controller for key="blkio" path="/sys/fs/cgroup/blkio/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651642 518133 cgroup.go:613] Removing cgroup controller for key="cpu" path="/sys/fs/cgroup/cpu/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651688 518133 cgroup.go:613] Removing cgroup controller for key="hugetlb" path="/sys/fs/cgroup/hugetlb/ci-gvisor-ptrace-1-race-1" D0711 20:34:45.651737 518133 cgroup.go:613] Removing cgroup controller for key="memory" path="/sys/fs/cgroup/memory/ci-gvisor-ptrace-1-race-1" I0711 20:34:45.655612 518133 cli.go:310] Exiting with status: 9