I0926 22:37:16.827605 48772 x:0] *************************** I0926 22:37:16.827816 48772 x:0] Args: [/syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/image -root /syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=exclusive -overlay -network=host -TESTONLY-unsafe-nonroot exec -user=0:0 -cap CAP_CHOWN -cap CAP_DAC_OVERRIDE -cap CAP_DAC_READ_SEARCH -cap CAP_FOWNER -cap CAP_FSETID -cap CAP_KILL -cap CAP_SETGID -cap CAP_SETUID -cap CAP_SETPCAP -cap CAP_LINUX_IMMUTABLE -cap CAP_NET_BIND_SERVICE -cap CAP_NET_BROADCAST -cap CAP_NET_ADMIN -cap CAP_NET_RAW -cap CAP_IPC_LOCK -cap CAP_IPC_OWNER -cap CAP_SYS_MODULE -cap CAP_SYS_RAWIO -cap CAP_SYS_CHROOT -cap CAP_SYS_PTRACE -cap CAP_SYS_PACCT -cap CAP_SYS_ADMIN -cap CAP_SYS_BOOT -cap CAP_SYS_NICE -cap CAP_SYS_RESOURCE -cap CAP_SYS_TIME -cap CAP_SYS_TTY_CONFIG -cap CAP_MKNOD -cap CAP_LEASE -cap CAP_AUDIT_WRITE -cap CAP_AUDIT_CONTROL -cap CAP_SETFCAP -cap CAP_MAC_OVERRIDE -cap CAP_MAC_ADMIN -cap CAP_SYSLOG -cap CAP_WAKE_ALARM -cap CAP_BLOCK_SUSPEND -cap CAP_AUDIT_READ ci-gvisor-ptrace-direct-overlay-host-race-test-0 /syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true] I0926 22:37:16.828171 48772 x:0] Version release-20190806.1-197-g543492650dd5 I0926 22:37:16.828210 48772 x:0] PID: 48772 I0926 22:37:16.828254 48772 x:0] UID: 0, GID: 0 I0926 22:37:16.828292 48772 x:0] Configuration: I0926 22:37:16.828321 48772 x:0] RootDir: /syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root I0926 22:37:16.828344 48772 x:0] Platform: ptrace I0926 22:37:16.828369 48772 x:0] FileAccess: exclusive, overlay: true I0926 22:37:16.828416 48772 x:0] Network: host, logging: false I0926 22:37:16.828469 48772 x:0] Strace: false, max size: 1024, syscalls: [] I0926 22:37:16.828504 48772 x:0] *************************** W0926 22:37:16.828523 48772 x:0] Block the TERM signal. This is only safe in tests! D0926 22:37:16.828925 48772 x:0] Load container "/syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root" "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.835709 48772 x:0] Signal container "ci-gvisor-ptrace-direct-overlay-host-race-test-0": signal 0 D0926 22:37:16.835862 48772 x:0] Signal sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.835917 48772 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.848714 48772 x:0] urpc: successfully marshalled 128 bytes. D0926 22:37:16.848954 48342 x:0] urpc: unmarshal success. D0926 22:37:16.849136 48342 x:0] containerManager.Signal &{CID:ci-gvisor-ptrace-direct-overlay-host-race-test-0 Signo:0 PID:0 Mode:Process} D0926 22:37:16.849377 48342 x:0] urpc: successfully marshalled 37 bytes. D0926 22:37:16.858834 48772 x:0] urpc: unmarshal success. D0926 22:37:16.858946 48772 x:0] Execute in container "ci-gvisor-ptrace-direct-overlay-host-race-test-0", args: /syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true D0926 22:37:16.859087 48772 x:0] Executing new process in container "ci-gvisor-ptrace-direct-overlay-host-race-test-0" in sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.859202 48772 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.860310 48342 x:0] urpc: unmarshal success. D0926 22:37:16.861445 48342 x:0] containerManager.ExecuteAsync: /syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true D0926 22:37:16.862645 48772 x:0] urpc: successfully marshalled 579 bytes. I0926 22:37:16.861958 48342 x:0] EXEC: [/syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true] D0926 22:37:16.862538 48342 x:0] send [channel @0xc00052e3c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-fuzzer]} D0926 22:37:16.863676 48342 x:0] recv [channel @0xc00052e3c0] Rwalkgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 20876640, BlockSize: 4096, Blocks: 40776, ATime: {Sec: 1569527862, NanoSec: 557981317}, MTime: {Sec: 1569527862, NanoSec: 557981317}, CTime: {Sec: 1569537436, NanoSec: 730559721}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 6687730}]} D0926 22:37:16.863945 48342 x:0] send [channel @0xc00052e3c0] Twalk{FID: 5, NewFID: 6, Names: []} D0926 22:37:16.864316 48342 x:0] recv [channel @0xc00052e3c0] Rwalk{QIDs: []} D0926 22:37:16.864405 48342 x:0] send [channel @0xc00052e3c0] Tlopen{FID: 6, Flags: ReadOnly} D0926 22:37:16.866148 48342 x:0] recv [channel @0xc00052e3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 6687730}, IoUnit: 0, File: &{{33}}} D0926 22:37:16.872243 48342 x:0] Allocating stack with size of 8388608 bytes D0926 22:37:16.873488 48342 x:0] updated processes: map[{ci-gvisor-ptrace-direct-overlay-host-race-test-0 0}:0xc00000e200 {ci-gvisor-ptrace-direct-overlay-host-race-test-0 16}:0xc00056e2a0] D0926 22:37:16.873776 48342 x:0] urpc: successfully marshalled 37 bytes. D0926 22:37:16.874148 48772 x:0] urpc: unmarshal success. D0926 22:37:16.874270 48772 x:0] Wait on PID 16 in container "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.874374 48772 x:0] Waiting for PID 16 in sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.874467 48772 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:16.874811 48772 x:0] urpc: successfully marshalled 111 bytes. D0926 22:37:16.876912 48342 x:0] urpc: unmarshal success. D0926 22:37:16.877141 48342 x:0] containerManager.Wait D0926 22:37:16.900762 48342 x:0] [ 16] Interrupt queued D0926 22:37:17.156993 48342 x:0] [ 17] Interrupt queued D0926 22:37:17.181409 48342 x:0] Clock(Monotonic): error: 399 ns, adjusted frequency from 2299806057 Hz to 2299807365 Hz D0926 22:37:17.181677 48342 x:0] Clock(Realtime): error: 374 ns, adjusted frequency from 2299806165 Hz to 2299807319 Hz D0926 22:37:17.181770 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157174554946608 monotonicBaseRef:2000198088 monotonicFrequency:2299807365 realtimeReady:1 realtimeBaseCycles:26157174555586530 realtimeBaseRef:1569537437181671863 realtimeFrequency:2299807319} D0926 22:37:17.183097 48342 x:0] [ 18] Interrupt queued D0926 22:37:17.199769 48342 x:0] [ 19] Interrupt queued D0926 22:37:17.256395 48342 x:0] [ 20] Interrupt queued D0926 22:37:17.324876 48342 x:0] [ 21] Interrupt queued D0926 22:37:17.391215 48342 x:0] [ 22] Interrupt queued D0926 22:37:17.423442 48342 x:0] [ 23] Interrupt queued D0926 22:37:17.478396 48342 x:0] [ 24] Interrupt queued 2019/09/26 22:37:17 fuzzer started D0926 22:37:17.563313 48342 x:0] [ 25] Interrupt queued D0926 22:37:17.589772 48342 x:0] [ 26] Interrupt queued D0926 22:37:17.633806 48342 x:0] [ 27] Interrupt queued D0926 22:37:17.701280 48342 x:0] [ 28] Interrupt queued D0926 22:37:17.769380 48342 x:0] [ 29] Interrupt queued D0926 22:37:17.792302 48342 x:0] [ 30] Interrupt queued D0926 22:37:17.805127 48342 x:0] [ 31] Interrupt queued D0926 22:37:17.817332 48342 x:0] [ 32] Interrupt queued 2019/09/26 22:37:17 connecting to host at stdin D0926 22:37:17.832568 48342 x:0] [ 33] Interrupt queued 2019/09/26 22:37:17 checking machine... 2019/09/26 22:37:17 checking revisions... D0926 22:37:17.841882 48342 x:0] [ 34] Interrupt queued D0926 22:37:17.845702 48342 x:0] [ 22] Entering internal stop (*kernel.vforkStop)(nil) D0926 22:37:17.846282 48342 x:0] [ 35] Interrupt queued D0926 22:37:17.888574 48342 x:0] send [channel @0xc00052e3c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syz-executor]} D0926 22:37:17.889598 48342 x:0] recv [channel @0xc00052e3c0] Rwalkgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1533512, BlockSize: 4096, Blocks: 3000, ATime: {Sec: 1569527862, NanoSec: 693992751}, MTime: {Sec: 1569527862, NanoSec: 693992751}, CTime: {Sec: 1569537436, NanoSec: 746561065}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 6687733}]} D0926 22:37:17.892346 48342 x:0] send [channel @0xc00052e3c0] Twalk{FID: 7, NewFID: 8, Names: []} D0926 22:37:17.892972 48342 x:0] recv [channel @0xc00052e3c0] Rwalk{QIDs: []} D0926 22:37:17.893181 48342 x:0] send [channel @0xc00052e3c0] Tlopen{FID: 8, Flags: ReadOnly} D0926 22:37:17.893822 48342 x:0] recv [channel @0xc00052e3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 6687733}, IoUnit: 0, File: &{{25}}} D0926 22:37:17.894874 48342 x:0] [ 35] Allocating stack with size of 8388608 bytes D0926 22:37:17.895956 48342 x:0] [ 22] Leaving internal stop (*kernel.vforkStop)(nil) D0926 22:37:17.972568 48342 x:0] [ 35] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:17.985536 48342 x:0] [ 35] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:17.985658 48342 x:0] [ 16] Notified of signal 17 D0926 22:37:17.985702 48342 x:0] [ 16] Interrupt queued D0926 22:37:17.985794 48342 x:0] [ 16] Interrupt queued D0926 22:37:17.985899 48342 x:0] [ 16] Restarting syscall 202 after errno 512: interrupted by signal 17 D0926 22:37:17.985964 48342 x:0] [ 16] Signal 17: delivering to handler D0926 22:37:17.988148 48342 x:0] [ 35] Transitioning from exit state TaskExitZombie to TaskExitDead 2019/09/26 22:37:18 testing simple program... D0926 22:37:18.004946 48342 x:0] [ 22] Entering internal stop (*kernel.vforkStop)(nil) D0926 22:37:18.007375 48342 x:0] [ 36] Interrupt queued D0926 22:37:18.018140 48342 x:0] [ 36] Allocating stack with size of 8388608 bytes D0926 22:37:18.018990 48342 x:0] [ 22] Leaving internal stop (*kernel.vforkStop)(nil) D0926 22:37:18.104852 48342 x:0] [ 36] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:18.117588 48342 x:0] [ 36] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:18.117727 48342 x:0] [ 16] Notified of signal 17 D0926 22:37:18.117990 48342 x:0] [ 16] Interrupt queued D0926 22:37:18.117955 48342 x:0] [ 16] Interrupt queued D0926 22:37:18.118234 48342 x:0] [ 16] Restarting syscall 202 after errno 512: interrupted by signal 17 D0926 22:37:18.118321 48342 x:0] [ 16] Signal 17: delivering to handler D0926 22:37:18.120090 48342 x:0] [ 36] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:18.144188 48342 x:0] [ 22] Entering internal stop (*kernel.vforkStop)(nil) D0926 22:37:18.155198 48342 x:0] [ 37] Interrupt queued D0926 22:37:18.162188 48342 x:0] [ 37] Allocating stack with size of 8388608 bytes D0926 22:37:18.163187 48342 x:0] [ 22] Leaving internal stop (*kernel.vforkStop)(nil) D0926 22:37:18.181421 48342 x:0] Clock(Monotonic): error: 194 ns, adjusted frequency from 2299807365 Hz to 2299806999 Hz D0926 22:37:18.181669 48342 x:0] Clock(Realtime): error: 56 ns, adjusted frequency from 2299807319 Hz to 2299806670 Hz D0926 22:37:18.181770 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157176854763734 monotonicBaseRef:3000202332 monotonicFrequency:2299806999 realtimeReady:1 realtimeBaseCycles:26157176855374956 realtimeBaseRef:1569537438181663647 realtimeFrequency:2299806670} D0926 22:37:18.253141 48342 x:0] [ 38] Interrupt queued D0926 22:37:18.326953 48342 x:0] [ 39] Interrupt queued D0926 22:37:18.352290 48342 x:0] [ 40] Interrupt queued D0926 22:37:19.162718 48342 x:0] [ 41] Interrupt queued D0926 22:37:19.165189 48342 x:0] [ 40] Interrupt queued D0926 22:37:19.165536 48342 x:0] [ 41] Interrupt queued D0926 22:37:19.165672 48342 x:0] [ 39] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.165944 48342 x:0] [ 39] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.166278 48342 x:0] [ 40] Interrupt queued D0926 22:37:19.166450 48342 x:0] [ 40] Signal 9: terminating thread group I0926 22:37:19.166600 48342 x:0] Uncaught signal: "killed" (9), PID: 39, TID: 40, fault addr: 0x0 D0926 22:37:19.166783 48342 x:0] [ 40] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.166948 48342 x:0] [ 40] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.167055 48342 x:0] [ 40] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.167204 48342 x:0] [ 41] Interrupt queued D0926 22:37:19.167334 48342 x:0] [ 41] Signal 9: terminating thread group I0926 22:37:19.167452 48342 x:0] Uncaught signal: "killed" (9), PID: 39, TID: 41, fault addr: 0x0 D0926 22:37:19.167580 48342 x:0] [ 41] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.168527 48342 x:0] [ 41] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.168617 48342 x:0] [ 41] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.168760 48342 x:0] [ 38] Discarding ignored signal 17 D0926 22:37:19.170079 48342 x:0] [ 39] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.181394 48342 x:0] Clock(Monotonic): error: -95 ns, adjusted frequency from 2299806999 Hz to 2299806340 Hz D0926 22:37:19.181584 48342 x:0] Clock(Realtime): error: 8 ns, adjusted frequency from 2299806670 Hz to 2299806602 Hz D0926 22:37:19.181678 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157179154512818 monotonicBaseRef:4000177149 monotonicFrequency:2299806340 realtimeReady:1 realtimeBaseCycles:26157179154984589 realtimeBaseRef:1569537439181577971 realtimeFrequency:2299806602} D0926 22:37:19.198769 48342 x:0] [ 37] Interrupt queued D0926 22:37:19.198988 48342 x:0] [ 37] No task notified of signal 9 D0926 22:37:19.198814 48342 x:0] [ 37] Interrupt queued D0926 22:37:19.199350 48342 x:0] [ 37] Signal 9: terminating thread group I0926 22:37:19.199499 48342 x:0] Uncaught signal: "killed" (9), PID: 37, TID: 37, fault addr: 0x0 D0926 22:37:19.199662 48342 x:0] [ 37] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.200541 48342 x:0] [ 38] Interrupt queued D0926 22:37:19.201471 48342 x:0] [ 38] Interrupt queued D0926 22:37:19.201785 48342 x:0] [ 38] No task notified of signal 9 D0926 22:37:19.202215 48342 x:0] [ 38] Signal 9: terminating thread group D0926 22:37:19.202295 48342 x:0] [ 37] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.202535 48342 x:0] [ 16] Notified of signal 17 D0926 22:37:19.202667 48342 x:0] [ 16] Interrupt queued D0926 22:37:19.202641 48342 x:0] [ 16] Interrupt queued I0926 22:37:19.203732 48342 x:0] Uncaught signal: "killed" (9), PID: 38, TID: 38, fault addr: 0x0 D0926 22:37:19.203045 48342 x:0] [ 16] Restarting syscall 202 after errno 512: interrupted by signal 17 D0926 22:37:19.208626 48342 x:0] [ 16] Signal 17: delivering to handler D0926 22:37:19.227314 48342 x:0] [ 37] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.228212 48342 x:0] [ 38] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.235662 48342 x:0] [ 38] Init process terminating, killing namespace D0926 22:37:19.235850 48342 x:0] [ 38] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.235995 48342 x:0] [ 1] Notified of signal 17 D0926 22:37:19.236101 48342 x:0] [ 1] Interrupt queued D0926 22:37:19.237625 48342 x:0] [ 1] Interrupt queued D0926 22:37:19.237873 48342 x:0] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 17 D0926 22:37:19.238172 48342 x:0] [ 1] Signal 17: delivering to handler 2019/09/26 22:37:19 BUG: simple call failed: {Flags:5 Signal:[65483392] Cover:[] Comps: Errno:999} D0926 22:37:19.275003 48342 x:0] [ 16] Interrupt queued D0926 22:37:19.275484 48342 x:0] [ 17] Interrupt queued D0926 22:37:19.275844 48342 x:0] [ 18] Interrupt queued D0926 22:37:19.275994 48342 x:0] [ 19] Interrupt queued D0926 22:37:19.275740 48342 x:0] [ 17] Interrupt queued D0926 22:37:19.276111 48342 x:0] [ 20] Interrupt queued D0926 22:37:19.276220 48342 x:0] [ 20] Interrupt queued D0926 22:37:19.275681 48342 x:0] [ 16] Interrupt queued D0926 22:37:19.276231 48342 x:0] [ 19] Interrupt queued D0926 22:37:19.276313 48342 x:0] [ 21] Interrupt queued D0926 22:37:19.276095 48342 x:0] [ 18] Interrupt queued D0926 22:37:19.276767 48342 x:0] [ 23] Interrupt queued D0926 22:37:19.276722 48342 x:0] [ 23] Interrupt queued D0926 22:37:19.276336 48342 x:0] [ 21] Interrupt queued D0926 22:37:19.276906 48342 x:0] [ 24] Interrupt queued D0926 22:37:19.276985 48342 x:0] [ 25] Interrupt queued D0926 22:37:19.277040 48342 x:0] [ 26] Interrupt queued D0926 22:37:19.277084 48342 x:0] [ 27] Interrupt queued D0926 22:37:19.277100 48342 x:0] [ 24] Interrupt queued D0926 22:37:19.277133 48342 x:0] [ 26] Interrupt queued D0926 22:37:19.277158 48342 x:0] [ 28] Interrupt queued D0926 22:37:19.277221 48342 x:0] [ 27] Interrupt queued D0926 22:37:19.277262 48342 x:0] [ 28] Interrupt queued D0926 22:37:19.277312 48342 x:0] [ 29] Interrupt queued D0926 22:37:19.277402 48342 x:0] [ 29] Interrupt queued D0926 22:37:19.277446 48342 x:0] [ 30] Interrupt queued D0926 22:37:19.277638 48342 x:0] [ 31] Interrupt queued D0926 22:37:19.277520 48342 x:0] [ 30] Interrupt queued D0926 22:37:19.277717 48342 x:0] [ 32] Interrupt queued D0926 22:37:19.277796 48342 x:0] [ 31] Interrupt queued D0926 22:37:19.278019 48342 x:0] [ 32] Interrupt queued D0926 22:37:19.279373 48342 x:0] [ 33] Interrupt queued D0926 22:37:19.279487 48342 x:0] [ 33] Interrupt queued D0926 22:37:19.279582 48342 x:0] [ 34] Interrupt queued D0926 22:37:19.279532 48342 x:0] [ 34] Interrupt queued D0926 22:37:19.279846 48342 x:0] [ 22] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.279980 48342 x:0] [ 17] Signal 9: terminating thread group D0926 22:37:19.280014 48342 x:0] [ 22] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.280116 48342 x:0] [ 22] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.280249 48342 x:0] [ 18] Signal 9: terminating thread group D0926 22:37:19.280334 48342 x:0] [ 23] Signal 9: terminating thread group D0926 22:37:19.280417 48342 x:0] [ 21] Signal 9: terminating thread group D0926 22:37:19.280509 48342 x:0] [ 24] Signal 9: terminating thread group D0926 22:37:19.280590 48342 x:0] [ 26] Signal 9: terminating thread group D0926 22:37:19.280678 48342 x:0] [ 27] Signal 9: terminating thread group D0926 22:37:19.280768 48342 x:0] [ 28] Signal 9: terminating thread group D0926 22:37:19.280861 48342 x:0] [ 29] Signal 9: terminating thread group D0926 22:37:19.280967 48342 x:0] [ 30] Signal 9: terminating thread group D0926 22:37:19.281055 48342 x:0] [ 31] Signal 9: terminating thread group D0926 22:37:19.281149 48342 x:0] [ 16] Signal 9: terminating thread group D0926 22:37:19.281221 48342 x:0] [ 32] Signal 9: terminating thread group D0926 22:37:19.281301 48342 x:0] [ 33] Signal 9: terminating thread group D0926 22:37:19.281383 48342 x:0] [ 34] Signal 9: terminating thread group D0926 22:37:19.281456 48342 x:0] [ 20] Signal 9: terminating thread group I0926 22:37:19.281671 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 17, fault addr: 0x0 I0926 22:37:19.281810 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 18, fault addr: 0x0 I0926 22:37:19.281952 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 21, fault addr: 0x0 I0926 22:37:19.282077 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 23, fault addr: 0x0 I0926 22:37:19.282183 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 30, fault addr: 0x0 I0926 22:37:19.282325 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 24, fault addr: 0x0 D0926 22:37:19.282318 48342 x:0] [ 17] Transitioning from exit state TaskExitNone to TaskExitInitiated I0926 22:37:19.282423 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 27, fault addr: 0x0 I0926 22:37:19.282550 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 28, fault addr: 0x0 D0926 22:37:19.282873 48342 x:0] [ 17] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.282997 48342 x:0] [ 17] Transitioning from exit state TaskExitZombie to TaskExitDead I0926 22:37:19.283003 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 26, fault addr: 0x0 D0926 22:37:19.283142 48342 x:0] [ 26] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.283217 48342 x:0] [ 18] Transitioning from exit state TaskExitNone to TaskExitInitiated I0926 22:37:19.283251 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 29, fault addr: 0x0 D0926 22:37:19.283320 48342 x:0] [ 21] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.283415 48342 x:0] [ 23] Transitioning from exit state TaskExitNone to TaskExitInitiated I0926 22:37:19.283384 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 31, fault addr: 0x0 D0926 22:37:19.283535 48342 x:0] [ 27] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.283648 48342 x:0] [ 27] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.283694 48342 x:0] [ 27] Transitioning from exit state TaskExitZombie to TaskExitDead I0926 22:37:19.283760 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 32, fault addr: 0x0 D0926 22:37:19.283895 48342 x:0] [ 32] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.284102 48342 x:0] [ 32] Transitioning from exit state TaskExitInitiated to TaskExitZombie I0926 22:37:19.283907 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 16, fault addr: 0x0 D0926 22:37:19.284233 48342 x:0] [ 32] Transitioning from exit state TaskExitZombie to TaskExitDead I0926 22:37:19.284320 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 20, fault addr: 0x0 D0926 22:37:19.284577 48342 x:0] [ 20] Transitioning from exit state TaskExitNone to TaskExitInitiated I0926 22:37:19.284505 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 34, fault addr: 0x0 I0926 22:37:19.284935 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 33, fault addr: 0x0 D0926 22:37:19.284754 48342 x:0] [ 31] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.285173 48342 x:0] [ 31] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.285288 48342 x:0] [ 31] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.280110 48342 x:0] [ 19] Signal 9: terminating thread group D0926 22:37:19.285456 48342 x:0] [ 16] Transitioning from exit state TaskExitNone to TaskExitInitiated I0926 22:37:19.285726 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 19, fault addr: 0x0 D0926 22:37:19.285961 48342 x:0] [ 16] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.286132 48342 x:0] [ 34] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.286307 48342 x:0] [ 34] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.286414 48342 x:0] [ 34] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.286663 48342 x:0] [ 24] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.286825 48342 x:0] [ 28] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.287145 48342 x:0] [ 29] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.287331 48342 x:0] [ 30] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.287519 48342 x:0] [ 33] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.287744 48342 x:0] [ 19] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.276997 48342 x:0] [ 25] Interrupt queued D0926 22:37:19.287978 48342 x:0] [ 28] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.288577 48342 x:0] [ 28] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.288732 48342 x:0] [ 25] Signal 9: terminating thread group I0926 22:37:19.289013 48342 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 25, fault addr: 0x0 D0926 22:37:19.289648 48342 x:0] [ 26] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.289850 48342 x:0] [ 26] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.290275 48342 x:0] [ 18] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.290410 48342 x:0] [ 18] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.290710 48342 x:0] [ 20] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.290788 48342 x:0] [ 20] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.290966 48342 x:0] [ 25] Transitioning from exit state TaskExitNone to TaskExitInitiated D0926 22:37:19.291110 48342 x:0] [ 21] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.291177 48342 x:0] [ 21] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.291285 48342 x:0] [ 23] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.291342 48342 x:0] [ 23] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.291495 48342 x:0] [ 29] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.291567 48342 x:0] [ 29] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.291740 48342 x:0] [ 30] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.291819 48342 x:0] [ 30] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.291990 48342 x:0] [ 33] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.292057 48342 x:0] [ 33] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.293090 48342 x:0] [ 19] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.293315 48342 x:0] [ 19] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.300738 48342 x:0] [ 24] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.300895 48342 x:0] [ 24] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.306063 48342 x:0] [ 25] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0926 22:37:19.306194 48342 x:0] [ 25] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.306366 48342 x:0] [ 16] Transitioning from exit state TaskExitZombie to TaskExitDead D0926 22:37:19.306632 48342 x:0] updated processes (removal): map[{ci-gvisor-ptrace-direct-overlay-host-race-test-0 0}:0xc00000e200] D0926 22:37:19.307102 48772 x:0] urpc: unmarshal success. I0926 22:37:19.307201 48772 x:0] Exiting with status: 256 D0926 22:37:19.312038 48342 x:0] urpc: successfully marshalled 38 bytes. DIAGNOSIS: I0926 22:37:19.381351 49397 x:0] *************************** I0926 22:37:19.381514 49397 x:0] Args: [/syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/image -root /syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=exclusive -overlay -network=host -TESTONLY-unsafe-nonroot debug -stacks ci-gvisor-ptrace-direct-overlay-host-race-test-0] I0926 22:37:19.381733 49397 x:0] Version release-20190806.1-197-g543492650dd5 I0926 22:37:19.381790 49397 x:0] PID: 49397 I0926 22:37:19.381900 49397 x:0] UID: 0, GID: 0 I0926 22:37:19.381955 49397 x:0] Configuration: I0926 22:37:19.382050 49397 x:0] RootDir: /syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root I0926 22:37:19.382133 49397 x:0] Platform: ptrace I0926 22:37:19.382267 49397 x:0] FileAccess: exclusive, overlay: true I0926 22:37:19.382595 49397 x:0] Network: host, logging: false I0926 22:37:19.382695 49397 x:0] Strace: false, max size: 1024, syscalls: [] I0926 22:37:19.382808 49397 x:0] *************************** W0926 22:37:19.382928 49397 x:0] Block the TERM signal. This is only safe in tests! D0926 22:37:19.383119 49397 x:0] Load container "/syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root" "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:19.390455 49397 x:0] Signal container "ci-gvisor-ptrace-direct-overlay-host-race-test-0": signal 0 D0926 22:37:19.390674 49397 x:0] Signal sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:19.390849 49397 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:19.392854 49397 x:0] urpc: successfully marshalled 128 bytes. D0926 22:37:19.393157 49397 x:0] urpc: unmarshal success. I0926 22:37:19.393410 49397 x:0] Found sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0", PID: 48342 I0926 22:37:19.393579 49397 x:0] Retrieving sandbox stacks D0926 22:37:19.393894 49397 x:0] Stacks sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:19.394043 49397 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-0" D0926 22:37:19.394485 49397 x:0] urpc: successfully marshalled 36 bytes. D0926 22:37:19.424645 49397 x:0] urpc: unmarshal success. I0926 22:37:19.425273 49397 x:0] *** Stack dump *** goroutine 214 [running]: gvisor.dev/gvisor/pkg/log.Stacks(0x460b01, 0xc00032d3e0, 0xc00012cae0, 0xc000572a80) pkg/log/log.go:272 +0xb6 gvisor.dev/gvisor/runsc/boot.(*debug).Stacks(0x23c5100, 0x23c5100, 0xc0001d27c0, 0x0, 0x0) runsc/boot/debug.go:26 +0x38 reflect.Value.call(0xc00032d3e0, 0xc0000101d0, 0x13, 0x1209c6a, 0x4, 0xc000547e78, 0x3, 0x3, 0x107a301, 0xc0001d27c0, ...) GOROOT/src/reflect/value.go:460 +0x62b reflect.Value.Call(0xc00032d3e0, 0xc0000101d0, 0x13, 0xc000547e78, 0x3, 0x3, 0x0, 0x23c5100, 0x16) GOROOT/src/reflect/value.go:321 +0xd4 gvisor.dev/gvisor/pkg/urpc.(*Server).handleOne(0xc00031c6c0, 0xc00012c900, 0x0, 0x0) pkg/urpc/urpc.go:325 +0x688 gvisor.dev/gvisor/pkg/urpc.(*Server).handleRegistered(0xc00031c6c0, 0xc00012c900, 0xc0001ae0f0, 0xc0006387e0) pkg/urpc/urpc.go:420 +0x43 gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc00031c6c0, 0xc00012c900) pkg/urpc/urpc.go:440 +0x81 created by gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling pkg/urpc/urpc.go:438 +0x6f goroutine 1 [semacquire]: sync.runtime_Semacquire(0xc00032e124) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc00032e124) GOROOT/src/sync/waitgroup.go:130 +0xb1 gvisor.dev/gvisor/pkg/sentry/kernel.(*Kernel).WaitExited(...) pkg/sentry/kernel/kernel.go:917 gvisor.dev/gvisor/runsc/boot.(*Loader).WaitExit(0xc00036e000, 0x0, 0x0) runsc/boot/loader.go:903 +0x73 gvisor.dev/gvisor/runsc/cmd.(*Boot).Execute(0xc0001ea240, 0x13677c0, 0xc000132000, 0xc0002b0360, 0xc00027eb40, 0x2, 0x2, 0x0) runsc/cmd/boot.go:254 +0x149e github.com/google/subcommands.(*Commander).Execute(0xc000148000, 0x13677c0, 0xc000132000, 0xc00027eb40, 0x2, 0x2, 0x0) external/com_github_google_subcommands/subcommands.go:200 +0x51d github.com/google/subcommands.Execute(...) external/com_github_google_subcommands/subcommands.go:481 main.main() runsc/main.go:291 +0x2b69 goroutine 21 [syscall]: os/signal.signal_recv(0x462821) GOROOT/src/runtime/sigqueue.go:147 +0x9c os/signal.loop() GOROOT/src/os/signal/signal_unix.go:23 +0x30 created by os/signal.init.0 GOROOT/src/os/signal/signal_unix.go:29 +0x4f goroutine 34 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0x123bff8, 0xc0002804e0, 0xc000280540) pkg/sentry/platform/ptrace/subprocess.go:174 +0x21e created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:158 +0x217 goroutine 35 [sync.Cond.Wait]: runtime.goparkunlock(...) GOROOT/src/runtime/proc.go:310 sync.runtime_notifyListWait(0xc0002aa948, 0xa) GOROOT/src/runtime/sema.go:510 +0xf8 sync.(*Cond).Wait(0xc0002aa938) GOROOT/src/sync/cond.go:56 +0x8e gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).findReclaimable(0xc0002aa500, 0x0, 0x0, 0x0) pkg/sentry/pgalloc/pgalloc.go:1090 +0xbb gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).runReclaim(0xc0002aa500) pkg/sentry/pgalloc/pgalloc.go:1019 +0x7b created by gvisor.dev/gvisor/pkg/sentry/pgalloc.NewMemoryFile pkg/sentry/pgalloc/pgalloc.go:330 +0x2f4 goroutine 4 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater.func1(0xc00032c000, 0xc00032e0a0) pkg/sentry/kernel/timekeeper.go:216 +0x204 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater pkg/sentry/kernel/timekeeper.go:184 +0xfe goroutine 6 [select]: reflect.rselect(0xc0002dc000, 0x22, 0x22, 0xc0002dc000, 0x1a25b00) GOROOT/src/runtime/select.go:542 +0x3bd reflect.Select(0xc00013b000, 0x22, 0x49, 0x0, 0x10d3bc0, 0x23c5100, 0x99, 0x0) GOROOT/src/reflect/value.go:2229 +0x1f0 gvisor.dev/gvisor/pkg/sentry/sighandling.handleSignals(0xc000034200, 0x21, 0x40, 0xc00036c090, 0xc000320420, 0xc000320480, 0xc0003204e0) pkg/sentry/sighandling/sighandling.go:46 +0x46c created by gvisor.dev/gvisor/pkg/sentry/sighandling.PrepareHandler pkg/sentry/sighandling/sighandling.go:131 +0x29d goroutine 7 [syscall]: syscall.Syscall6(0x10f, 0xc000396e68, 0x2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:44 +0x5 gvisor.dev/gvisor/pkg/unet.(*Socket).wait(0xc00031c630, 0xffffffffffffff00, 0x0, 0x0) pkg/unet/unet_unsafe.go:55 +0xda gvisor.dev/gvisor/pkg/unet.(*ServerSocket).Accept(0xc000010038, 0x0, 0x0, 0x0) pkg/unet/unet.go:539 +0x189 gvisor.dev/gvisor/pkg/control/server.(*Server).serve(0xc00000e260) pkg/control/server/server.go:99 +0x50 gvisor.dev/gvisor/pkg/control/server.(*Server).StartServing.func1(0xc00000e260) pkg/control/server/server.go:87 +0x39 created by gvisor.dev/gvisor/pkg/control/server.(*Server).StartServing pkg/control/server/server.go:86 +0xc9 goroutine 28 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc000228000, 0xc0004647e0, 0x0, 0x46438c, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc000228000, 0xc0004647e0, 0x1368b00, 0x0, 0xc4200cbd48, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc000228000, 0x0, 0xc000228001, 0xc4200cbd48, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc000228000, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0002638e0, 0xc000263900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc000228000, 0xca, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc000228000, 0xca, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc0004820f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc000228000, 0xca, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000263ce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc000228000, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc000228000, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc000228000, 0xa) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 43 [syscall]: syscall.Syscall6(0x119, 0x10, 0xc0000eaae0, 0x64, 0xffffffffffffffff, 0x0, 0x0, 0xc00031a0e8, 0x46438c, 0x47492f) src/syscall/asm_linux_amd64.s:44 +0x5 gvisor.dev/gvisor/pkg/fdnotifier.epollWait(0x10, 0xc0000eaae0, 0x64, 0x64, 0xffffffffffffffff, 0x1, 0x0, 0x0) pkg/fdnotifier/poll_unsafe.go:77 +0x83 gvisor.dev/gvisor/pkg/fdnotifier.(*notifier).waitAndNotify(0xc00031a0e0, 0x0, 0xf3f150) pkg/fdnotifier/fdnotifier.go:149 +0x9e created by gvisor.dev/gvisor/pkg/fdnotifier.newNotifier pkg/fdnotifier/fdnotifier.go:64 +0x114 goroutine 44 [syscall]: syscall.Syscall6(0x10f, 0xc0000d0000, 0x1, 0x0, 0x0, 0x0, 0x0, 0x200, 0x1a25180, 0x7f79b9cb9bb8) src/syscall/asm_linux_amd64.s:44 +0x5 golang.org/x/sys/unix.ppoll(0xc0000d0000, 0x1, 0x0, 0x0, 0xc0000d0000, 0x10, 0x101000000000028) external/org_golang_x_sys/unix/zsyscall_linux_amd64.go:79 +0xa2 golang.org/x/sys/unix.Ppoll(0xc0000d0000, 0x1, 0x1, 0x0, 0x0, 0x0, 0x0, 0x448d60) external/org_golang_x_sys/unix/syscall_linux.go:133 +0xda gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor.func1.1(0xe1416a, 0x8, 0x1, 0x0) runsc/boot/loader.go:711 +0x60 gvisor.dev/gvisor/runsc/specutils.RetryEintr(0xc000392f80, 0x8, 0x0, 0x0, 0x1) runsc/specutils/specutils.go:503 +0x39 gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor.func1(0x7fffb4caefb8, 0x30, 0xc0001ddf68, 0x1, 0x1, 0xc00036e000) runsc/boot/loader.go:709 +0x25a created by gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor runsc/boot/loader.go:700 +0x7f goroutine 45 [syscall]: syscall.Syscall6(0x10f, 0xc0004c2720, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:44 +0x5 golang.org/x/sys/unix.ppoll(0xc0004c2720, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0) external/org_golang_x_sys/unix/zsyscall_linux_amd64.go:79 +0xa2 golang.org/x/sys/unix.Ppoll(0xc0004c2720, 0x1, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0) external/org_golang_x_sys/unix/syscall_linux.go:133 +0xda gvisor.dev/gvisor/pkg/p9.(*Client).watch(0xc000294100, 0xc00039c060) pkg/p9/client.go:251 +0xda created by gvisor.dev/gvisor/pkg/p9.NewClient pkg/p9/client.go:231 +0x75e goroutine 47 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001ea120) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 48 [select]: gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).loop(0xc000330070) pkg/sentry/watchdog/watchdog.go:181 +0x144 created by gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).Start pkg/sentry/watchdog/watchdog.go:155 +0x305 goroutine 49 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001ea2d0) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 114 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc00026c000, 0xc000320f00, 0x0, 0x69040b, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00026c000, 0xc000320f00, 0x1368b00, 0x0, 0x3658288, 0x5bf600, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00026c000, 0x0, 0xc420009c01, 0x3658288, 0x0, 0xffffffff, 0xf3f0b0, 0x7f7988050c88, 0xc0003c9710) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00026c000, 0x3658288, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0005bf8e0, 0xc0005bf900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00026c000, 0xca, 0x3658288, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00026c000, 0xca, 0x3658288, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc00053c0f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00026c000, 0xca, 0x3658288, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0005bfce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00026c000, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00026c000, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc00026c000, 0x1) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 131 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0003a0090) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 132 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0002de000, 0xc0002800c0, 0xc000280120) pkg/sentry/platform/ptrace/subprocess.go:174 +0x21e created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:158 +0x217 goroutine 133 [semacquire]: sync.runtime_Semacquire(0xc0004016b8) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc0004016b0) GOROOT/src/sync/waitgroup.go:130 +0xb1 gvisor.dev/gvisor/pkg/sentry/kernel.(*ThreadGroup).WaitExited(...) pkg/sentry/kernel/task_run.go:333 gvisor.dev/gvisor/runsc/boot.(*Loader).wait(0xc00036e000, 0xc000401000, 0x30) runsc/boot/loader.go:891 +0x43 gvisor.dev/gvisor/runsc/boot.(*Loader).waitContainer(0xc00036e000, 0xc000332000, 0x30, 0xc000310018, 0x0, 0xc0004120f0) runsc/boot/loader.go:846 +0x1af gvisor.dev/gvisor/runsc/boot.(*containerManager).Wait(0xc00000e280, 0xc0000f2010, 0xc000310018, 0x0, 0x0) runsc/boot/controller.go:426 +0xb9 reflect.Value.call(0xc00032d320, 0xc000010190, 0x13, 0x1209c6a, 0x4, 0xc000267e78, 0x3, 0x3, 0x1077501, 0xc000310018, ...) GOROOT/src/reflect/value.go:460 +0x62b reflect.Value.Call(0xc00032d320, 0xc000010190, 0x13, 0xc000267e78, 0x3, 0x3, 0x0, 0xc00000e280, 0x16) GOROOT/src/reflect/value.go:321 +0xd4 gvisor.dev/gvisor/pkg/urpc.(*Server).handleOne(0xc00031c6c0, 0xc0003f2000, 0x0, 0x0) pkg/urpc/urpc.go:325 +0x688 gvisor.dev/gvisor/pkg/urpc.(*Server).handleRegistered(0xc00031c6c0, 0xc0003f2000, 0x0, 0x0) pkg/urpc/urpc.go:420 +0x43 gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc00031c6c0, 0xc0003f2000) pkg/urpc/urpc.go:440 +0x81 created by gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling pkg/urpc/urpc.go:438 +0x6f goroutine 23 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc00045e000, 0xc000450180, 0xc000120120, 0x0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc00045e000, 0xc000450180, 0xc00045e801, 0xe526592fd, 0x0, 0xc00035e0c8) pkg/sentry/kernel/task_block.go:79 +0xda gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00045e000, 0xc000450180, 0x1368b01, 0xdf8475800, 0x36574d0, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:41 +0x11d gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00045e000, 0xdf8475800, 0x0, 0x36574d0, 0x0, 0xffffffff, 0xa8c9e3, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00045e000, 0x36574d0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc0002698e0, 0xc000269900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00045e000, 0xca, 0x36574d0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00045e000, 0xca, 0x36574d0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x13570c0, 0xc0004e40f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00045e000, 0xca, 0x36574d0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc000269ce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00045e000, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00045e000, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc00045e000, 0x2) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 147 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00036c120) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 24 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc00045ea80, 0xc000450420, 0x0, 0x46438c, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00045ea80, 0xc000450420, 0x1368b00, 0x0, 0x3676100, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00045ea80, 0x0, 0xc00045ea01, 0x3676100, 0x200d0100, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00045ea80, 0x3676100, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0005498e0, 0xc000549900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00045ea80, 0xca, 0x3676100, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00045ea80, 0xca, 0x3676100, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc0004820f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00045ea80, 0xca, 0x3676100, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000549ce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00045ea80, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00045ea80, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc00045ea80, 0x3) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 67 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0002f2000) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 25 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc00045f500, 0xc000450780, 0x0, 0x0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00045f500, 0xc000450780, 0x1368b00, 0x0, 0xc4200ca948, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00045f500, 0x0, 0xc00045f501, 0xc4200ca948, 0x100, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00045f500, 0xc4200ca948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004998e0, 0xc000499900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00045f500, 0xca, 0xc4200ca948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00045f500, 0xca, 0xc4200ca948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc00053c0f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00045f500, 0xca, 0xc4200ca948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000499ce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00045f500, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00045f500, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc00045f500, 0x4) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 134 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0003a0120) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 148 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc000582000, 0xc0001205a0, 0x0, 0x46438c, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc000582000, 0xc0001205a0, 0x1368b00, 0x0, 0xc4200cb948, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc000582000, 0x0, 0xc000582001, 0xc4200cb948, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc000582000, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003bd8e0, 0xc0003bd900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc000582000, 0xca, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc000582000, 0xca, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc00053c0f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc000582000, 0xca, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003bdce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc000582000, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc000582000, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc000582000, 0x5) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 149 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00036c1b0) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 26 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0005b6000, 0xc00053a660, 0x0, 0x46438c, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0005b6000, 0xc00053a660, 0x1368b00, 0x0, 0xc42020c148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0005b6000, 0x0, 0xc0005b6001, 0xc42020c148, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0005b6000, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004958e0, 0xc000495900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0005b6000, 0xca, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0005b6000, 0xca, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc00053c0f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0005b6000, 0xca, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000495ce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0005b6000, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0005b6000, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0005b6000, 0x6) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 194 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0005e4000) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 29 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc000228a80, 0xc000465740, 0x0, 0xc0004a15d8, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc000228a80, 0xc000465740, 0x1368b00, 0x0, 0xc420486148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc000228a80, 0x0, 0xc000228a01, 0xc420486148, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc000228a80, 0xc420486148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004a18e0, 0xc0004a1900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc000228a80, 0xca, 0xc420486148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc000228a80, 0xca, 0xc420486148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc000482000) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc000228a80, 0xca, 0xc420486148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004a1ce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc000228a80, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc000228a80, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc000228a80, 0xd) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 30 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc000229500, 0xc000465a40, 0x0, 0x0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc000229500, 0xc000465a40, 0x1368b00, 0x0, 0xc4204b0548, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc000229500, 0x0, 0x1, 0xc4204b0548, 0x204c0100, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc000229500, 0xc4204b0548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003c18e0, 0xc0003c1900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc000229500, 0xca, 0xc4204b0548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc000229500, 0xca, 0xc4204b0548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc0003145a0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc000229500, 0xca, 0xc4204b0548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003c1ce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc000229500, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc000229500, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc000229500, 0xf) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 125 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0002df0c0, 0xc0004e8180, 0xc0004e81e0) pkg/sentry/platform/ptrace/subprocess.go:174 +0x21e created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:158 +0x217 goroutine 68 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0003a0240) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 69 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004ec000, 0xc000281260, 0x0, 0x0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004ec000, 0xc000281260, 0x1368b00, 0x0, 0xc4204b0148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004ec000, 0x0, 0xc0004ec001, 0xc4204b0148, 0x204c0100, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004ec000, 0xc4204b0148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00049d8e0, 0xc00049d900, 0x47ea53, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004ec000, 0xca, 0xc4204b0148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1208640, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0004ec000, 0xca, 0xc4204b0148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13570c0, 0xc0004822d0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0004ec000, 0xca, 0xc4204b0148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00049dce8, 0xde13f5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0004ec000, 0x2, 0xc00031e140) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0004ec000, 0x13570c0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0004ec000, 0xe) pkg/sentry/kernel/task_run.go:91 +0x309 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:300 +0x19e goroutine 140 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001a42d0) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 227 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004f2000) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 31 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0002f21b0) pkg/sentry/kernel/time/time.go:512 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:491 +0x246 goroutine 261 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0000f2a90, 0xc00050e720, 0xc00050e780) pkg/sentry/platform/ptrace/subprocess.go:174 +0x21e created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:158 +0x217 goroutine 239 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0000f2cc0, 0xc000451f80, 0xc000320180) pkg/sentry/platform/ptrace/subprocess.go:174 +0x21e created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:158 +0x217 goroutine 173 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0004f4000, 0xc00050ed20, 0xc00050ed80) pkg/sentry/platform/ptrace/subprocess.go:174 +0x21e created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:158 +0x217 I0926 22:37:19.425725 49397 x:0] Exiting with status: 0 D0926 22:37:19.392097 48342 x:0] urpc: unmarshal success. D0926 22:37:19.392276 48342 x:0] containerManager.Signal &{CID:ci-gvisor-ptrace-direct-overlay-host-race-test-0 Signo:0 PID:0 Mode:Process} D0926 22:37:19.392458 48342 x:0] urpc: successfully marshalled 37 bytes. D0926 22:37:19.394679 48342 x:0] urpc: unmarshal success. D0926 22:37:19.399061 48342 x:0] urpc: successfully marshalled 31756 bytes. D0926 22:37:20.181549 48342 x:0] Clock(Monotonic): error: 193 ns, adjusted frequency from 2299806340 Hz to 2299807047 Hz D0926 22:37:20.181790 48342 x:0] Clock(Realtime): error: 181 ns, adjusted frequency from 2299806602 Hz to 2299807039 Hz D0926 22:37:20.181891 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157181454576550 monotonicBaseRef:5000289067 monotonicFrequency:2299807047 realtimeReady:1 realtimeBaseCycles:26157181455266166 realtimeBaseRef:1569537440181784499 realtimeFrequency:2299807039} D0926 22:37:21.181876 48342 x:0] Clock(Monotonic): error: -89 ns, adjusted frequency from 2299807047 Hz to 2299806412 Hz D0926 22:37:21.182108 48342 x:0] Clock(Realtime): error: -73 ns, adjusted frequency from 2299807039 Hz to 2299806460 Hz D0926 22:37:21.182215 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157183755238067 monotonicBaseRef:6000660606 monotonicFrequency:2299806412 realtimeReady:1 realtimeBaseCycles:26157183755804241 realtimeBaseRef:1569537441182102367 realtimeFrequency:2299806460} D0926 22:37:22.181452 48342 x:0] Clock(Monotonic): error: 102 ns, adjusted frequency from 2299806412 Hz to 2299806871 Hz D0926 22:37:22.181599 48342 x:0] Clock(Realtime): error: 218 ns, adjusted frequency from 2299806460 Hz to 2299807156 Hz D0926 22:37:22.181691 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157186054077356 monotonicBaseRef:7000240082 monotonicFrequency:2299806871 realtimeReady:1 realtimeBaseCycles:26157186054430733 realtimeBaseRef:1569537442181589294 realtimeFrequency:2299807156} D0926 22:37:23.181453 48342 x:0] Clock(Monotonic): error: 72 ns, adjusted frequency from 2299806871 Hz to 2299806805 Hz D0926 22:37:23.181627 48342 x:0] Clock(Realtime): error: -48 ns, adjusted frequency from 2299807156 Hz to 2299806545 Hz D0926 22:37:23.181728 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157188353848148 monotonicBaseRef:8000224394 monotonicFrequency:2299806805 realtimeReady:1 realtimeBaseCycles:26157188354306999 realtimeBaseRef:1569537443181619344 realtimeFrequency:2299806545} D0926 22:37:24.181432 48342 x:0] Clock(Monotonic): error: 82 ns, adjusted frequency from 2299806805 Hz to 2299806843 Hz D0926 22:37:24.181610 48342 x:0] Clock(Realtime): error: -74 ns, adjusted frequency from 2299806545 Hz to 2299806488 Hz D0926 22:37:24.181695 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157190653638932 monotonicBaseRef:9000217427 monotonicFrequency:2299806843 realtimeReady:1 realtimeBaseCycles:26157190654071924 realtimeBaseRef:1569537444181601246 realtimeFrequency:2299806488} D0926 22:37:25.181458 48342 x:0] Clock(Monotonic): error: -18 ns, adjusted frequency from 2299806843 Hz to 2299806687 Hz D0926 22:37:25.181613 48342 x:0] Clock(Realtime): error: 125 ns, adjusted frequency from 2299806488 Hz to 2299807010 Hz D0926 22:37:25.181685 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157192953516060 monotonicBaseRef:10000247988 monotonicFrequency:2299806687 realtimeReady:1 realtimeBaseCycles:26157192953895126 realtimeBaseRef:1569537445181608513 realtimeFrequency:2299807010} D0926 22:37:26.181451 48342 x:0] Clock(Monotonic): error: 20 ns, adjusted frequency from 2299806687 Hz to 2299806764 Hz D0926 22:37:26.181620 48342 x:0] Clock(Realtime): error: -72 ns, adjusted frequency from 2299807010 Hz to 2299806548 Hz D0926 22:37:26.181722 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157195253301998 monotonicBaseRef:11000238965 monotonicFrequency:2299806764 realtimeReady:1 realtimeBaseCycles:26157195253714096 realtimeBaseRef:1569537446181613713 realtimeFrequency:2299806548} D0926 22:37:27.181816 48342 x:0] Clock(Monotonic): error: -139 ns, adjusted frequency from 2299806764 Hz to 2299806383 Hz D0926 22:37:27.181966 48342 x:0] Clock(Realtime): error: -47 ns, adjusted frequency from 2299806548 Hz to 2299806601 Hz D0926 22:37:27.182056 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157197553948274 monotonicBaseRef:12000604000 monotonicFrequency:2299806383 realtimeReady:1 realtimeBaseCycles:26157197554310632 realtimeBaseRef:1569537447181957214 realtimeFrequency:2299806601} D0926 22:37:28.181488 48342 x:0] Clock(Monotonic): error: 14 ns, adjusted frequency from 2299806383 Hz to 2299806745 Hz D0926 22:37:28.181646 48342 x:0] Clock(Realtime): error: -10 ns, adjusted frequency from 2299806601 Hz to 2299806687 Hz D0926 22:37:28.181751 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157199853007048 monotonicBaseRef:13000278925 monotonicFrequency:2299806745 realtimeReady:1 realtimeBaseCycles:26157199853390853 realtimeBaseRef:1569537448181641370 realtimeFrequency:2299806687} D0926 22:37:29.181488 48342 x:0] Clock(Monotonic): error: 125 ns, adjusted frequency from 2299806745 Hz to 2299807006 Hz D0926 22:37:29.181705 48342 x:0] Clock(Realtime): error: 12 ns, adjusted frequency from 2299806687 Hz to 2299806735 Hz D0926 22:37:29.181817 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157202152804467 monotonicBaseRef:14000274869 monotonicFrequency:2299807006 realtimeReady:1 realtimeBaseCycles:26157202153329373 realtimeBaseRef:1569537449181698693 realtimeFrequency:2299806735} D0926 22:37:30.183076 48342 x:0] Clock(Monotonic): error: 18 ns, adjusted frequency from 2299807006 Hz to 2299806759 Hz D0926 22:37:30.183257 48342 x:0] Clock(Realtime): error: 181 ns, adjusted frequency from 2299806735 Hz to 2299807141 Hz D0926 22:37:30.183363 48342 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:26157204456271293 monotonicBaseRef:15001866228 monotonicFrequency:2299806759 realtimeReady:1 realtimeBaseCycles:26157204456703834 realtimeBaseRef:1569537450183250008 realtimeFrequency:2299807141}