Extracting prog: 3m36.886612211s Minimizing prog: 25m0.266753511s Simplifying prog options: 0s Extracting C: 1m51.37251843s Simplifying C: 2m55.721053175s extracting reproducer from 1 programs testing a last program of every proc single: executing 1 programs separately with timeout 45s testing program (duration=45s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-open-fallocate detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) r0 = open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) program did not crash single: failed to extract reproducer single: executing 1 programs separately with timeout 5m0s testing program (duration=5m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-open-fallocate detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) r0 = open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) 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=5m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-open detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) program did not crash testing program (duration=5m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-fallocate detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) fallocate(0xffffffffffffffff, 0x0, 0x3, 0x4000000800) program did not crash testing program (duration=5m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): open-fallocate detailed listing: executing program 0: r0 = open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) program did not crash testing program (duration=5m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-open-fallocate detailed listing: executing program 0: setrlimit(0x1, 0x0) r0 = open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) program did not crash testing program (duration=5m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-open-fallocate detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) r0 = open(0x0, 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) program did not crash extracting C reproducer testing compiled C program (duration=5m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-open-fallocate program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF simplifying C reproducer testing compiled C program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 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}}): setrlimit-open-fallocate program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF testing compiled C program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false 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}}): setrlimit-open-fallocate program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF testing compiled C program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:false HandleSegv:true Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): setrlimit-open-fallocate program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF testing compiled C program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:false HandleSegv:false Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): setrlimit-open-fallocate program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF testing compiled C program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:false Swap:false UseTmpDir:false HandleSegv:false Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): setrlimit-open-fallocate program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF testing program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:false Swap:false UseTmpDir:false HandleSegv:false Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): setrlimit-open-fallocate detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) r0 = open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF validation run: crashed=true testing program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:false Swap:false UseTmpDir:false HandleSegv:false Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): setrlimit-open-fallocate detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) r0 = open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF validation run: crashed=true testing program (duration=5m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:1 Slowdown:10 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:false Swap:false UseTmpDir:false HandleSegv:false Trace:false CallComments:true LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): setrlimit-open-fallocate detailed listing: executing program 0: setrlimit(0x1, &(0x7f0000000000)={0xfffffffffffffff2, 0xfffffffffffffffe}) r0 = open(&(0x7f0000000100)='./bus\x00', 0x1ed2fd, 0x100) fallocate(r0, 0x0, 0x3, 0x4000000800) program crashed: FATAL ERROR: waiting on pid X: waiting on pid X in sandbox NAME failed: EOF validation run: crashed=true reproducing took 35m45.651687377s repro crashed as (corrupted=false): W0713 00:37:23.537053 97715 util.go:107] FATAL ERROR: waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-2-race-cover-1": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-2-race-cover-1": urpc method "containerManager.WaitPID" failed: EOF W0713 00:37:23.537223 97715 cli.go:319] Failure to execute command, err: 1 D0713 00:37:24.113103 1 connection.go:150] sock read failed, closing connection: EOF W0713 00:37:24.113196 96702 sandbox.go:1455] Wait RPC to container "ci-gvisor-ptrace-2-race-cover-1" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. I0713 00:37:24.113427 1 gofer.go:444] All lisafs servers exited. I0713 00:37:24.113534 1 cli.go:310] Exiting with status: 0 D0713 00:37:24.120600 96702 container.go:906] Destroy container, cid: ci-gvisor-ptrace-2-race-cover-1 D0713 00:37:24.120720 96702 container.go:1255] Destroying container, cid: ci-gvisor-ptrace-2-race-cover-1 D0713 00:37:24.120754 96702 sandbox.go:2196] Destroying root container by destroying sandbox, cid: ci-gvisor-ptrace-2-race-cover-1 D0713 00:37:24.120791 96702 sandbox.go:1526] Destroying sandbox "ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.120911 96702 container.go:1269] Killing gofer for container, cid: ci-gvisor-ptrace-2-race-cover-1, PID: 96733 D0713 00:37:24.152092 96702 cgroup.go:605] Deleting cgroup "ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152244 96702 cgroup.go:613] Removing cgroup controller for key="blkio" path="/sys/fs/cgroup/blkio/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152583 96702 cgroup.go:613] Removing cgroup controller for key="memory" path="/sys/fs/cgroup/memory/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152812 96702 cgroup.go:613] Removing cgroup controller for key="net_prio" path="/sys/fs/cgroup/net_prio/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152929 96702 cgroup.go:613] Removing cgroup controller for key="cpuacct" path="/sys/fs/cgroup/cpuacct/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153060 96702 cgroup.go:613] Removing cgroup controller for key="devices" path="/sys/fs/cgroup/devices/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153131 96702 cgroup.go:613] Removing cgroup controller for key="freezer" path="/sys/fs/cgroup/freezer/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153205 96702 cgroup.go:613] Removing cgroup controller for key="perf_event" path="/sys/fs/cgroup/perf_event/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153277 96702 cgroup.go:613] Removing cgroup controller for key="systemd" path="/sys/fs/cgroup/systemd/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153439 96702 cgroup.go:613] Removing cgroup controller for key="cpu" path="/sys/fs/cgroup/cpu/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153538 96702 cgroup.go:613] Removing cgroup controller for key="cpuset" path="/sys/fs/cgroup/cpuset/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153613 96702 cgroup.go:613] Removing cgroup controller for key="hugetlb" path="/sys/fs/cgroup/hugetlb/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153752 96702 cgroup.go:613] Removing cgroup controller for key="net_cls" path="/sys/fs/cgroup/net_cls/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.154037 96702 cgroup.go:613] Removing cgroup controller for key="pids" path="/sys/fs/cgroup/pids/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.154131 96702 cgroup.go:613] Removing cgroup controller for key="rdma" path="/sys/fs/cgroup/rdma/ci-gvisor-ptrace-2-race-cover-1" I0713 00:37:24.154685 96702 cli.go:310] Exiting with status: 9 final repro crashed as (corrupted=false): W0713 00:37:23.537053 97715 util.go:107] FATAL ERROR: waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-2-race-cover-1": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 32: waiting on PID 32 in sandbox "ci-gvisor-ptrace-2-race-cover-1": urpc method "containerManager.WaitPID" failed: EOF W0713 00:37:23.537223 97715 cli.go:319] Failure to execute command, err: 1 D0713 00:37:24.113103 1 connection.go:150] sock read failed, closing connection: EOF W0713 00:37:24.113196 96702 sandbox.go:1455] Wait RPC to container "ci-gvisor-ptrace-2-race-cover-1" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. I0713 00:37:24.113427 1 gofer.go:444] All lisafs servers exited. I0713 00:37:24.113534 1 cli.go:310] Exiting with status: 0 D0713 00:37:24.120600 96702 container.go:906] Destroy container, cid: ci-gvisor-ptrace-2-race-cover-1 D0713 00:37:24.120720 96702 container.go:1255] Destroying container, cid: ci-gvisor-ptrace-2-race-cover-1 D0713 00:37:24.120754 96702 sandbox.go:2196] Destroying root container by destroying sandbox, cid: ci-gvisor-ptrace-2-race-cover-1 D0713 00:37:24.120791 96702 sandbox.go:1526] Destroying sandbox "ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.120911 96702 container.go:1269] Killing gofer for container, cid: ci-gvisor-ptrace-2-race-cover-1, PID: 96733 D0713 00:37:24.152092 96702 cgroup.go:605] Deleting cgroup "ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152244 96702 cgroup.go:613] Removing cgroup controller for key="blkio" path="/sys/fs/cgroup/blkio/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152583 96702 cgroup.go:613] Removing cgroup controller for key="memory" path="/sys/fs/cgroup/memory/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152812 96702 cgroup.go:613] Removing cgroup controller for key="net_prio" path="/sys/fs/cgroup/net_prio/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.152929 96702 cgroup.go:613] Removing cgroup controller for key="cpuacct" path="/sys/fs/cgroup/cpuacct/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153060 96702 cgroup.go:613] Removing cgroup controller for key="devices" path="/sys/fs/cgroup/devices/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153131 96702 cgroup.go:613] Removing cgroup controller for key="freezer" path="/sys/fs/cgroup/freezer/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153205 96702 cgroup.go:613] Removing cgroup controller for key="perf_event" path="/sys/fs/cgroup/perf_event/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153277 96702 cgroup.go:613] Removing cgroup controller for key="systemd" path="/sys/fs/cgroup/systemd/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153439 96702 cgroup.go:613] Removing cgroup controller for key="cpu" path="/sys/fs/cgroup/cpu/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153538 96702 cgroup.go:613] Removing cgroup controller for key="cpuset" path="/sys/fs/cgroup/cpuset/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153613 96702 cgroup.go:613] Removing cgroup controller for key="hugetlb" path="/sys/fs/cgroup/hugetlb/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.153752 96702 cgroup.go:613] Removing cgroup controller for key="net_cls" path="/sys/fs/cgroup/net_cls/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.154037 96702 cgroup.go:613] Removing cgroup controller for key="pids" path="/sys/fs/cgroup/pids/ci-gvisor-ptrace-2-race-cover-1" D0713 00:37:24.154131 96702 cgroup.go:613] Removing cgroup controller for key="rdma" path="/sys/fs/cgroup/rdma/ci-gvisor-ptrace-2-race-cover-1" I0713 00:37:24.154685 96702 cli.go:310] Exiting with status: 9