Extracting prog: 1m51.618327884s
Minimizing prog: 25m0.277901787s
Simplifying prog options: 0s
Extracting C: 37.042681541s
Simplifying C: 2m56.097864032s


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 32m48.473976166s
repro crashed as (corrupted=false):
W0713 00:28:01.784510   77531 util.go:107] FATAL ERROR: waiting on pid 31: waiting on PID 31 in sandbox "ci-gvisor-systrap-1-race-cover-0": urpc method "containerManager.WaitPID" failed: EOF
waiting on pid 31: waiting on PID 31 in sandbox "ci-gvisor-systrap-1-race-cover-0": urpc method "containerManager.WaitPID" failed: EOF
W0713 00:28:01.784665   77531 cli.go:319] Failure to execute command, err: 1
D0713 00:28:02.445656       1 connection.go:150] sock read failed, closing connection: EOF
W0713 00:28:02.445750   76811 sandbox.go:1455] Wait RPC to container "ci-gvisor-systrap-1-race-cover-0" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead.
I0713 00:28:02.446119       1 gofer.go:444] All lisafs servers exited.
I0713 00:28:02.446211       1 cli.go:310] Exiting with status: 0
D0713 00:28:02.510999   76811 container.go:906] Destroy container, cid: ci-gvisor-systrap-1-race-cover-0
D0713 00:28:02.511183   76811 container.go:1255] Destroying container, cid: ci-gvisor-systrap-1-race-cover-0
D0713 00:28:02.511231   76811 sandbox.go:2196] Destroying root container by destroying sandbox, cid: ci-gvisor-systrap-1-race-cover-0
D0713 00:28:02.511278   76811 sandbox.go:1526] Destroying sandbox "ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.511411   76811 container.go:1269] Killing gofer for container, cid: ci-gvisor-systrap-1-race-cover-0, PID: 76850
D0713 00:28:02.540227   76811 cgroup.go:605] Deleting cgroup "ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540412   76811 cgroup.go:613] Removing cgroup controller for key="cpu" path="/sys/fs/cgroup/cpu/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540635   76811 cgroup.go:613] Removing cgroup controller for key="cpuset" path="/sys/fs/cgroup/cpuset/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540724   76811 cgroup.go:613] Removing cgroup controller for key="hugetlb" path="/sys/fs/cgroup/hugetlb/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540796   76811 cgroup.go:613] Removing cgroup controller for key="memory" path="/sys/fs/cgroup/memory/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540910   76811 cgroup.go:613] Removing cgroup controller for key="net_prio" path="/sys/fs/cgroup/net_prio/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541054   76811 cgroup.go:613] Removing cgroup controller for key="pids" path="/sys/fs/cgroup/pids/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541130   76811 cgroup.go:613] Removing cgroup controller for key="cpuacct" path="/sys/fs/cgroup/cpuacct/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541236   76811 cgroup.go:613] Removing cgroup controller for key="perf_event" path="/sys/fs/cgroup/perf_event/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541348   76811 cgroup.go:613] Removing cgroup controller for key="blkio" path="/sys/fs/cgroup/blkio/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541493   76811 cgroup.go:613] Removing cgroup controller for key="net_cls" path="/sys/fs/cgroup/net_cls/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541580   76811 cgroup.go:613] Removing cgroup controller for key="devices" path="/sys/fs/cgroup/devices/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541665   76811 cgroup.go:613] Removing cgroup controller for key="freezer" path="/sys/fs/cgroup/freezer/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541738   76811 cgroup.go:613] Removing cgroup controller for key="rdma" path="/sys/fs/cgroup/rdma/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541836   76811 cgroup.go:613] Removing cgroup controller for key="systemd" path="/sys/fs/cgroup/systemd/ci-gvisor-systrap-1-race-cover-0"
I0713 00:28:02.542545   76811 cli.go:310] Exiting with status: 9

final repro crashed as (corrupted=false):
W0713 00:28:01.784510   77531 util.go:107] FATAL ERROR: waiting on pid 31: waiting on PID 31 in sandbox "ci-gvisor-systrap-1-race-cover-0": urpc method "containerManager.WaitPID" failed: EOF
waiting on pid 31: waiting on PID 31 in sandbox "ci-gvisor-systrap-1-race-cover-0": urpc method "containerManager.WaitPID" failed: EOF
W0713 00:28:01.784665   77531 cli.go:319] Failure to execute command, err: 1
D0713 00:28:02.445656       1 connection.go:150] sock read failed, closing connection: EOF
W0713 00:28:02.445750   76811 sandbox.go:1455] Wait RPC to container "ci-gvisor-systrap-1-race-cover-0" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead.
I0713 00:28:02.446119       1 gofer.go:444] All lisafs servers exited.
I0713 00:28:02.446211       1 cli.go:310] Exiting with status: 0
D0713 00:28:02.510999   76811 container.go:906] Destroy container, cid: ci-gvisor-systrap-1-race-cover-0
D0713 00:28:02.511183   76811 container.go:1255] Destroying container, cid: ci-gvisor-systrap-1-race-cover-0
D0713 00:28:02.511231   76811 sandbox.go:2196] Destroying root container by destroying sandbox, cid: ci-gvisor-systrap-1-race-cover-0
D0713 00:28:02.511278   76811 sandbox.go:1526] Destroying sandbox "ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.511411   76811 container.go:1269] Killing gofer for container, cid: ci-gvisor-systrap-1-race-cover-0, PID: 76850
D0713 00:28:02.540227   76811 cgroup.go:605] Deleting cgroup "ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540412   76811 cgroup.go:613] Removing cgroup controller for key="cpu" path="/sys/fs/cgroup/cpu/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540635   76811 cgroup.go:613] Removing cgroup controller for key="cpuset" path="/sys/fs/cgroup/cpuset/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540724   76811 cgroup.go:613] Removing cgroup controller for key="hugetlb" path="/sys/fs/cgroup/hugetlb/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540796   76811 cgroup.go:613] Removing cgroup controller for key="memory" path="/sys/fs/cgroup/memory/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.540910   76811 cgroup.go:613] Removing cgroup controller for key="net_prio" path="/sys/fs/cgroup/net_prio/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541054   76811 cgroup.go:613] Removing cgroup controller for key="pids" path="/sys/fs/cgroup/pids/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541130   76811 cgroup.go:613] Removing cgroup controller for key="cpuacct" path="/sys/fs/cgroup/cpuacct/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541236   76811 cgroup.go:613] Removing cgroup controller for key="perf_event" path="/sys/fs/cgroup/perf_event/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541348   76811 cgroup.go:613] Removing cgroup controller for key="blkio" path="/sys/fs/cgroup/blkio/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541493   76811 cgroup.go:613] Removing cgroup controller for key="net_cls" path="/sys/fs/cgroup/net_cls/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541580   76811 cgroup.go:613] Removing cgroup controller for key="devices" path="/sys/fs/cgroup/devices/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541665   76811 cgroup.go:613] Removing cgroup controller for key="freezer" path="/sys/fs/cgroup/freezer/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541738   76811 cgroup.go:613] Removing cgroup controller for key="rdma" path="/sys/fs/cgroup/rdma/ci-gvisor-systrap-1-race-cover-0"
D0713 00:28:02.541836   76811 cgroup.go:613] Removing cgroup controller for key="systemd" path="/sys/fs/cgroup/systemd/ci-gvisor-systrap-1-race-cover-0"
I0713 00:28:02.542545   76811 cli.go:310] Exiting with status: 9