I1202 13:49:05.865135 8179 x:0] *************************** I1202 13:49:05.865250 8179 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-2 /syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true] I1202 13:49:05.865728 8179 x:0] Version release-20191114.0-43-gaa70523da215 I1202 13:49:05.865792 8179 x:0] PID: 8179 I1202 13:49:05.865840 8179 x:0] UID: 0, GID: 0 I1202 13:49:05.865874 8179 x:0] Configuration: I1202 13:49:05.865929 8179 x:0] RootDir: /syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root I1202 13:49:05.865959 8179 x:0] Platform: ptrace I1202 13:49:05.865998 8179 x:0] FileAccess: exclusive, overlay: true I1202 13:49:05.866059 8179 x:0] Network: host, logging: false I1202 13:49:05.866097 8179 x:0] Strace: false, max size: 1024, syscalls: [] I1202 13:49:05.866137 8179 x:0] *************************** W1202 13:49:05.866174 8179 x:0] Block the TERM signal. This is only safe in tests! D1202 13:49:05.866571 8179 x:0] Load container "/syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root" "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.873785 8179 x:0] Signal container "ci-gvisor-ptrace-direct-overlay-host-race-test-2": signal 0 D1202 13:49:05.873922 8179 x:0] Signal sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.873969 8179 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.875165 7940 x:0] urpc: unmarshal success. D1202 13:49:05.875321 7940 x:0] containerManager.Signal &{CID:ci-gvisor-ptrace-direct-overlay-host-race-test-2 Signo:0 PID:0 Mode:Process} D1202 13:49:05.875554 7940 x:0] urpc: successfully marshalled 37 bytes. D1202 13:49:05.875659 8179 x:0] urpc: successfully marshalled 128 bytes. D1202 13:49:05.875934 8179 x:0] urpc: unmarshal success. D1202 13:49:05.876099 8179 x:0] Exec arguments: /syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true D1202 13:49:05.876239 8179 x:0] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D1202 13:49:05.876386 8179 x:0] Execute in container "ci-gvisor-ptrace-direct-overlay-host-race-test-2", args: /syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true D1202 13:49:05.876565 8179 x:0] Executing new process in container "ci-gvisor-ptrace-direct-overlay-host-race-test-2" in sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.876753 8179 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.878357 7940 x:0] urpc: unmarshal success. D1202 13:49:05.879211 7940 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 I1202 13:49:05.879614 7940 x:0] EXEC: [/syz-fuzzer -executor=/syz-executor -name=test -arch=amd64 -manager=stdin -sandbox=none -procs=0 -cover=false -debug=false -test=true] D1202 13:49:05.880032 7940 x:0] send [channel @0xc0002946c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-fuzzer]} D1202 13:49:05.881708 8179 x:0] urpc: successfully marshalled 579 bytes. D1202 13:49:05.882405 7940 x:0] recv [channel @0xc0002946c0] 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: 21953408, BlockSize: 4096, Blocks: 42880, ATime: {Sec: 1575226840, NanoSec: 884869437}, MTime: {Sec: 1575226840, NanoSec: 884869437}, CTime: {Sec: 1575294545, NanoSec: 798499481}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 15865714}]} D1202 13:49:05.883830 7940 x:0] send [channel @0xc0002946c0] Twalk{FID: 5, NewFID: 6, Names: []} D1202 13:49:05.886327 7940 x:0] recv [channel @0xc0002946c0] Rwalk{QIDs: []} D1202 13:49:05.886718 7940 x:0] send [channel @0xc0002946c0] Tlopen{FID: 6, Flags: ReadOnly} D1202 13:49:05.887701 7940 x:0] recv [channel @0xc0002946c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 15865714}, IoUnit: 0, File: &{{35}}} D1202 13:49:05.897659 7940 x:0] Allocating stack with size of 8388608 bytes D1202 13:49:05.900447 7940 x:0] updated processes: map[{ci-gvisor-ptrace-direct-overlay-host-race-test-2 0}:0xc000320200 {ci-gvisor-ptrace-direct-overlay-host-race-test-2 16}:0xc00013fba0] D1202 13:49:05.901002 8179 x:0] urpc: unmarshal success. D1202 13:49:05.901188 8179 x:0] Wait on PID 16 in container "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.901362 8179 x:0] Waiting for PID 16 in sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.900813 7940 x:0] urpc: successfully marshalled 37 bytes. D1202 13:49:05.901548 8179 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:05.902798 8179 x:0] urpc: successfully marshalled 111 bytes. D1202 13:49:05.903084 7940 x:0] urpc: unmarshal success. D1202 13:49:05.903304 7940 x:0] containerManager.Wait D1202 13:49:05.916276 7940 x:0] [ 16] Interrupt queued D1202 13:49:06.305629 7940 x:0] [ 17] Interrupt queued D1202 13:49:06.341157 7940 x:0] [ 18] Interrupt queued D1202 13:49:06.351654 7940 x:0] [ 19] Interrupt queued D1202 13:49:06.433931 7940 x:0] [ 20] Interrupt queued D1202 13:49:06.435872 7940 x:0] [ 21] Interrupt queued D1202 13:49:06.441649 7940 x:0] [ 22] Interrupt queued D1202 13:49:06.465328 7940 x:0] Clock(Monotonic): error: 23 ns, adjusted frequency from 2299805864 Hz to 2299806001 Hz D1202 13:49:06.466341 7940 x:0] Clock(Realtime): error: -27 ns, adjusted frequency from 2299805741 Hz to 2299805772 Hz D1202 13:49:06.466580 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397411691214167 monotonicBaseRef:2000209581 monotonicFrequency:2299806001 realtimeReady:1 realtimeBaseCycles:39397411693562337 realtimeBaseRef:1575294546466333154 realtimeFrequency:2299805772} D1202 13:49:06.491369 7940 x:0] [ 23] Interrupt queued 2019/12/02 13:49:06 fuzzer started D1202 13:49:06.614618 7940 x:0] [ 24] Interrupt queued D1202 13:49:06.626799 7940 x:0] [ 25] Interrupt queued D1202 13:49:06.659300 7940 x:0] [ 26] Interrupt queued D1202 13:49:06.705223 7940 x:0] [ 27] Interrupt queued D1202 13:49:06.743006 7940 x:0] [ 28] Interrupt queued D1202 13:49:06.769916 7940 x:0] [ 29] Interrupt queued D1202 13:49:06.819789 7940 x:0] [ 30] Interrupt queued D1202 13:49:06.865011 7940 x:0] [ 31] Interrupt queued D1202 13:49:06.879549 7940 x:0] [ 32] Interrupt queued 2019/12/02 13:49:06 connecting to host at stdin D1202 13:49:06.886283 7940 x:0] [ 33] Interrupt queued D1202 13:49:06.917470 7940 x:0] [ 34] Interrupt queued 2019/12/02 13:49:06 checking machine... 2019/12/02 13:49:06 checking revisions... D1202 13:49:06.941587 7940 x:0] [ 24] Entering internal stop (*kernel.vforkStop)(nil) D1202 13:49:06.942146 7940 x:0] [ 35] Interrupt queued D1202 13:49:06.950823 7940 x:0] send [channel @0xc0002946c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syz-executor]} D1202 13:49:06.953174 7940 x:0] recv [channel @0xc0002946c0] 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: 1550176, BlockSize: 4096, Blocks: 3032, ATime: {Sec: 1575226829, NanoSec: 635921298}, MTime: {Sec: 1575226829, NanoSec: 635921298}, CTime: {Sec: 1575294545, NanoSec: 802499819}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 15865715}]} D1202 13:49:06.953889 7940 x:0] send [channel @0xc0002946c0] Twalk{FID: 7, NewFID: 8, Names: []} D1202 13:49:06.954790 7940 x:0] recv [channel @0xc0002946c0] Rwalk{QIDs: []} D1202 13:49:06.955143 7940 x:0] send [channel @0xc0002946c0] Tlopen{FID: 8, Flags: ReadOnly} D1202 13:49:06.955778 7940 x:0] recv [channel @0xc0002946c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 15865715}, IoUnit: 0, File: &{{29}}} D1202 13:49:06.957503 7940 x:0] [ 35] Allocating stack with size of 8388608 bytes D1202 13:49:06.960755 7940 x:0] [ 24] Leaving internal stop (*kernel.vforkStop)(nil) D1202 13:49:07.055401 7940 x:0] [ 35] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:07.056722 7940 x:0] [ 35] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:07.056912 7940 x:0] [ 16] Notified of signal 17 D1202 13:49:07.057054 7940 x:0] [ 16] Interrupt queued D1202 13:49:07.057220 7940 x:0] [ 16] Interrupt queued D1202 13:49:07.057365 7940 x:0] [ 16] Restarting syscall 202 after errno 512: interrupted by signal 17 D1202 13:49:07.057500 7940 x:0] [ 16] Signal 17: delivering to handler D1202 13:49:07.065630 7940 x:0] [ 35] Transitioning from exit state TaskExitZombie to TaskExitDead 2019/12/02 13:49:07 testing simple program... D1202 13:49:07.118395 7940 x:0] [ 25] Entering internal stop (*kernel.vforkStop)(nil) D1202 13:49:07.119247 7940 x:0] [ 36] Interrupt queued D1202 13:49:07.151710 7940 x:0] [ 36] Allocating stack with size of 8388608 bytes D1202 13:49:07.152949 7940 x:0] [ 25] Leaving internal stop (*kernel.vforkStop)(nil) D1202 13:49:07.178585 7940 x:0] [ 36] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:07.183265 7940 x:0] [ 36] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:07.183447 7940 x:0] [ 16] Notified of signal 17 D1202 13:49:07.183640 7940 x:0] [ 16] Interrupt queued D1202 13:49:07.184169 7940 x:0] [ 16] Interrupt queued D1202 13:49:07.184371 7940 x:0] [ 16] Restarting syscall 202 after errno 512: interrupted by signal 17 D1202 13:49:07.184452 7940 x:0] [ 16] Signal 17: delivering to handler D1202 13:49:07.185596 7940 x:0] [ 36] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:07.208904 7940 x:0] [ 25] Entering internal stop (*kernel.vforkStop)(nil) D1202 13:49:07.211458 7940 x:0] [ 37] Interrupt queued D1202 13:49:07.226800 7940 x:0] [ 37] Allocating stack with size of 8388608 bytes D1202 13:49:07.228384 7940 x:0] [ 25] Leaving internal stop (*kernel.vforkStop)(nil) D1202 13:49:07.300157 7940 x:0] [ 38] Interrupt queued D1202 13:49:07.372767 7940 x:0] [ 39] Interrupt queued D1202 13:49:07.414100 7940 x:0] [ 40] Interrupt queued D1202 13:49:07.465738 7940 x:0] Clock(Monotonic): error: 28 ns, adjusted frequency from 2299806001 Hz to 2299806038 Hz D1202 13:49:07.465999 7940 x:0] Clock(Realtime): error: 132 ns, adjusted frequency from 2299805772 Hz to 2299806258 Hz D1202 13:49:07.466373 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397413991953611 monotonicBaseRef:3000615460 monotonicFrequency:2299806038 realtimeReady:1 realtimeBaseCycles:39397413992588007 realtimeBaseRef:1575294547465993950 realtimeFrequency:2299806258} D1202 13:49:08.217188 7940 x:0] [ 41] Interrupt queued D1202 13:49:08.233769 7940 x:0] [ 40] Interrupt queued D1202 13:49:08.233928 7940 x:0] [ 40] Interrupt queued D1202 13:49:08.234057 7940 x:0] [ 41] Interrupt queued D1202 13:49:08.234129 7940 x:0] [ 39] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.234241 7940 x:0] [ 41] Interrupt queued D1202 13:49:08.234317 7940 x:0] [ 39] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.234495 7940 x:0] [ 40] Signal 9: terminating thread group D1202 13:49:08.234398 7940 x:0] [ 41] Signal 9: terminating thread group I1202 13:49:08.234612 7940 x:0] Uncaught signal: "killed" (9), PID: 39, TID: 40, fault addr: 0x0 D1202 13:49:08.234751 7940 x:0] [ 40] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.234915 7940 x:0] [ 40] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.234993 7940 x:0] [ 40] Transitioning from exit state TaskExitZombie to TaskExitDead I1202 13:49:08.235155 7940 x:0] Uncaught signal: "killed" (9), PID: 39, TID: 41, fault addr: 0x0 D1202 13:49:08.235271 7940 x:0] [ 41] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.237453 7940 x:0] [ 41] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.237555 7940 x:0] [ 41] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.237681 7940 x:0] [ 38] Discarding ignored signal 17 D1202 13:49:08.238280 7940 x:0] [ 39] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.241061 7940 x:0] [ 37] Interrupt queued D1202 13:49:08.241255 7940 x:0] [ 37] Notified of signal 9 D1202 13:49:08.241377 7940 x:0] [ 37] Interrupt queued D1202 13:49:08.242888 7940 x:0] [ 37] Dropping duplicate interrupt D1202 13:49:08.243022 7940 x:0] [ 37] Signal 9: terminating thread group I1202 13:49:08.243102 7940 x:0] Uncaught signal: "killed" (9), PID: 37, TID: 37, fault addr: 0x0 D1202 13:49:08.243183 7940 x:0] [ 37] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.244035 7940 x:0] [ 38] Interrupt queued D1202 13:49:08.244159 7940 x:0] [ 38] No task notified of signal 9 D1202 13:49:08.244633 7940 x:0] [ 37] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.244815 7940 x:0] [ 16] Notified of signal 17 D1202 13:49:08.244854 7940 x:0] [ 38] Signal 9: terminating thread group D1202 13:49:08.244950 7940 x:0] [ 16] Interrupt queued I1202 13:49:08.245111 7940 x:0] Uncaught signal: "killed" (9), PID: 38, TID: 38, fault addr: 0x0 D1202 13:49:08.245313 7940 x:0] [ 38] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.245029 7940 x:0] [ 16] Interrupt queued D1202 13:49:08.245539 7940 x:0] [ 37] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.245668 7940 x:0] [ 16] Restarting syscall 202 after errno 512: interrupted by signal 17 D1202 13:49:08.245766 7940 x:0] [ 16] Signal 17: delivering to handler D1202 13:49:08.247272 7940 x:0] [ 38] Init process terminating, killing namespace D1202 13:49:08.247347 7940 x:0] [ 38] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.247429 7940 x:0] [ 1] Notified of signal 17 D1202 13:49:08.247490 7940 x:0] [ 1] Interrupt queued D1202 13:49:08.247554 7940 x:0] [ 1] Interrupt queued D1202 13:49:08.247746 7940 x:0] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 17 D1202 13:49:08.247831 7940 x:0] [ 1] Signal 17: delivering to handler 2019/12/02 13:49:08 BUG: simple call failed: {Flags:5 Signal:[65484552] Cover:[] Comps: Errno:999} D1202 13:49:08.271075 7940 x:0] [ 16] Interrupt queued D1202 13:49:08.271244 7940 x:0] [ 17] Interrupt queued D1202 13:49:08.271391 7940 x:0] [ 18] Interrupt queued D1202 13:49:08.271479 7940 x:0] [ 17] Interrupt queued D1202 13:49:08.271387 7940 x:0] [ 16] Interrupt queued D1202 13:49:08.271726 7940 x:0] [ 18] Interrupt queued D1202 13:49:08.271720 7940 x:0] [ 19] Interrupt queued D1202 13:49:08.273203 7940 x:0] [ 20] Interrupt queued D1202 13:49:08.273265 7940 x:0] [ 21] Interrupt queued D1202 13:49:08.273313 7940 x:0] [ 22] Interrupt queued D1202 13:49:08.273354 7940 x:0] [ 23] Interrupt queued D1202 13:49:08.273417 7940 x:0] [ 24] Interrupt queued D1202 13:49:08.273493 7940 x:0] [ 25] Interrupt queued D1202 13:49:08.273555 7940 x:0] [ 26] Interrupt queued D1202 13:49:08.273598 7940 x:0] [ 27] Interrupt queued D1202 13:49:08.273646 7940 x:0] [ 28] Interrupt queued D1202 13:49:08.273712 7940 x:0] [ 29] Interrupt queued D1202 13:49:08.273794 7940 x:0] [ 30] Interrupt queued D1202 13:49:08.273837 7940 x:0] [ 31] Interrupt queued D1202 13:49:08.273888 7940 x:0] [ 32] Interrupt queued D1202 13:49:08.273939 7940 x:0] [ 34] Interrupt queued D1202 13:49:08.273990 7940 x:0] [ 33] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.274197 7940 x:0] [ 33] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.274281 7940 x:0] [ 33] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.274724 7940 x:0] [ 17] Signal 9: terminating thread group I1202 13:49:08.274841 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 17, fault addr: 0x0 D1202 13:49:08.274936 7940 x:0] [ 17] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.275019 7940 x:0] [ 17] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.275076 7940 x:0] [ 17] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.275212 7940 x:0] [ 20] Interrupt queued D1202 13:49:08.275297 7940 x:0] [ 20] Signal 9: terminating thread group D1202 13:49:08.275286 7940 x:0] [ 27] Interrupt queued I1202 13:49:08.275355 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 20, fault addr: 0x0 D1202 13:49:08.275403 7940 x:0] [ 27] Signal 9: terminating thread group D1202 13:49:08.275468 7940 x:0] [ 21] Interrupt queued D1202 13:49:08.275461 7940 x:0] [ 20] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.275550 7940 x:0] [ 30] Interrupt queued D1202 13:49:08.275618 7940 x:0] [ 21] Signal 9: terminating thread group D1202 13:49:08.275644 7940 x:0] [ 30] Signal 9: terminating thread group D1202 13:49:08.275700 7940 x:0] [ 29] Interrupt queued D1202 13:49:08.275726 7940 x:0] [ 22] Interrupt queued D1202 13:49:08.275800 7940 x:0] [ 29] Signal 9: terminating thread group D1202 13:49:08.275876 7940 x:0] [ 32] Interrupt queued D1202 13:49:08.275864 7940 x:0] [ 23] Interrupt queued D1202 13:49:08.275971 7940 x:0] [ 32] Signal 9: terminating thread group D1202 13:49:08.275989 7940 x:0] [ 23] Signal 9: terminating thread group D1202 13:49:08.276038 7940 x:0] [ 34] Interrupt queued D1202 13:49:08.276055 7940 x:0] [ 24] Interrupt queued D1202 13:49:08.276122 7940 x:0] [ 34] Signal 9: terminating thread group D1202 13:49:08.276158 7940 x:0] [ 24] Signal 9: terminating thread group D1202 13:49:08.276187 7940 x:0] [ 31] Interrupt queued D1202 13:49:08.276210 7940 x:0] [ 26] Interrupt queued D1202 13:49:08.276302 7940 x:0] [ 31] Signal 9: terminating thread group D1202 13:49:08.276321 7940 x:0] [ 26] Signal 9: terminating thread group D1202 13:49:08.276395 7940 x:0] [ 25] Interrupt queued D1202 13:49:08.276415 7940 x:0] [ 16] Signal 9: terminating thread group D1202 13:49:08.276490 7940 x:0] [ 25] Signal 9: terminating thread group D1202 13:49:08.276515 7940 x:0] [ 18] Signal 9: terminating thread group D1202 13:49:08.276545 7940 x:0] [ 28] Interrupt queued D1202 13:49:08.276636 7940 x:0] [ 28] Signal 9: terminating thread group D1202 13:49:08.275817 7940 x:0] [ 22] Signal 9: terminating thread group I1202 13:49:08.276616 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 25, fault addr: 0x0 D1202 13:49:08.276959 7940 x:0] [ 20] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.277154 7940 x:0] [ 20] Transitioning from exit state TaskExitZombie to TaskExitDead I1202 13:49:08.277381 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 28, fault addr: 0x0 I1202 13:49:08.277572 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 23, fault addr: 0x0 I1202 13:49:08.277766 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 22, fault addr: 0x0 I1202 13:49:08.277933 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 24, fault addr: 0x0 I1202 13:49:08.278138 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 27, fault addr: 0x0 I1202 13:49:08.278275 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 21, fault addr: 0x0 I1202 13:49:08.278419 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 30, fault addr: 0x0 D1202 13:49:08.278103 7940 x:0] [ 28] Transitioning from exit state TaskExitNone to TaskExitInitiated I1202 13:49:08.278637 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 32, fault addr: 0x0 I1202 13:49:08.279525 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 29, fault addr: 0x0 I1202 13:49:08.279664 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 26, fault addr: 0x0 D1202 13:49:08.279789 7940 x:0] [ 32] Transitioning from exit state TaskExitNone to TaskExitInitiated I1202 13:49:08.280020 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 34, fault addr: 0x0 D1202 13:49:08.280147 7940 x:0] [ 23] Transitioning from exit state TaskExitNone to TaskExitInitiated I1202 13:49:08.280171 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 31, fault addr: 0x0 D1202 13:49:08.280256 7940 x:0] [ 22] Transitioning from exit state TaskExitNone to TaskExitInitiated I1202 13:49:08.280276 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 16, fault addr: 0x0 D1202 13:49:08.280390 7940 x:0] [ 25] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.280479 7940 x:0] [ 29] Transitioning from exit state TaskExitNone to TaskExitInitiated I1202 13:49:08.280396 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 18, fault addr: 0x0 D1202 13:49:08.280594 7940 x:0] [ 29] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.280658 7940 x:0] [ 29] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.280809 7940 x:0] [ 18] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.280901 7940 x:0] [ 18] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.280955 7940 x:0] [ 18] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.281071 7940 x:0] [ 24] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.281136 7940 x:0] [ 24] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.281187 7940 x:0] [ 24] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.281345 7940 x:0] [ 27] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.281440 7940 x:0] [ 27] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.281493 7940 x:0] [ 27] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.281652 7940 x:0] [ 32] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.281705 7940 x:0] [ 32] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.281820 7940 x:0] [ 30] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.281909 7940 x:0] [ 30] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.281959 7940 x:0] [ 30] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.282069 7940 x:0] [ 21] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.282162 7940 x:0] [ 21] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.282216 7940 x:0] [ 21] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.282385 7940 x:0] [ 26] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.282471 7940 x:0] [ 26] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.282544 7940 x:0] [ 26] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.282676 7940 x:0] [ 23] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.282729 7940 x:0] [ 23] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.282846 7940 x:0] [ 34] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.282940 7940 x:0] [ 34] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.283008 7940 x:0] [ 34] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.283189 7940 x:0] [ 22] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.283247 7940 x:0] [ 22] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.283411 7940 x:0] [ 31] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.283496 7940 x:0] [ 31] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.283555 7940 x:0] [ 31] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.283695 7940 x:0] [ 16] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.283784 7940 x:0] [ 16] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.283926 7940 x:0] [ 25] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.284001 7940 x:0] [ 25] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.285138 7940 x:0] [ 28] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.285437 7940 x:0] [ 28] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.271847 7940 x:0] [ 19] Interrupt queued D1202 13:49:08.293345 7940 x:0] [ 19] Signal 9: terminating thread group I1202 13:49:08.293639 7940 x:0] Uncaught signal: "killed" (9), PID: 16, TID: 19, fault addr: 0x0 D1202 13:49:08.293932 7940 x:0] [ 19] Transitioning from exit state TaskExitNone to TaskExitInitiated D1202 13:49:08.299063 7940 x:0] [ 19] Transitioning from exit state TaskExitInitiated to TaskExitZombie D1202 13:49:08.299192 7940 x:0] [ 19] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.299321 7940 x:0] [ 16] Transitioning from exit state TaskExitZombie to TaskExitDead D1202 13:49:08.310085 7940 x:0] updated processes (removal): map[{ci-gvisor-ptrace-direct-overlay-host-race-test-2 0}:0xc000320200] D1202 13:49:08.310546 7940 x:0] urpc: successfully marshalled 38 bytes. D1202 13:49:08.310825 8179 x:0] urpc: unmarshal success. I1202 13:49:08.311496 8179 x:0] Exiting with status: 256 DIAGNOSIS: I1202 13:49:08.397045 8444 x:0] *************************** I1202 13:49:08.397125 8444 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-2] I1202 13:49:08.397260 8444 x:0] Version release-20191114.0-43-gaa70523da215 I1202 13:49:08.397305 8444 x:0] PID: 8444 I1202 13:49:08.397331 8444 x:0] UID: 0, GID: 0 I1202 13:49:08.397372 8444 x:0] Configuration: I1202 13:49:08.400150 8444 x:0] RootDir: /syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root I1202 13:49:08.400245 8444 x:0] Platform: ptrace I1202 13:49:08.400291 8444 x:0] FileAccess: exclusive, overlay: true I1202 13:49:08.400367 8444 x:0] Network: host, logging: false I1202 13:49:08.400409 8444 x:0] Strace: false, max size: 1024, syscalls: [] I1202 13:49:08.400443 8444 x:0] *************************** W1202 13:49:08.400480 8444 x:0] Block the TERM signal. This is only safe in tests! D1202 13:49:08.400621 8444 x:0] Load container "/syzkaller/managers/ptrace-direct-overlay-host-race/latest.tmp/workdir/gvisor_root" "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:08.406782 8444 x:0] Signal container "ci-gvisor-ptrace-direct-overlay-host-race-test-2": signal 0 D1202 13:49:08.406883 8444 x:0] Signal sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:08.406935 8444 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:08.418537 8444 x:0] urpc: successfully marshalled 128 bytes. D1202 13:49:08.419009 8444 x:0] urpc: unmarshal success. I1202 13:49:08.419261 8444 x:0] Found sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2", PID: 7940 I1202 13:49:08.419369 8444 x:0] Retrieving sandbox stacks D1202 13:49:08.419467 8444 x:0] Stacks sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:08.419564 8444 x:0] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-test-2" D1202 13:49:08.425312 8444 x:0] urpc: successfully marshalled 36 bytes. D1202 13:49:08.434829 8444 x:0] urpc: unmarshal success. I1202 13:49:08.435085 8444 x:0] *** Stack dump *** goroutine 246 [running]: gvisor.dev/gvisor/pkg/log.Stacks(0x460d01, 0xc00039a8a0, 0xc00051e510, 0xc000486000) pkg/log/log.go:272 +0xb6 gvisor.dev/gvisor/runsc/boot.(*debug).Stacks(0x244d5e8, 0x244d5e8, 0xc0000f2140, 0x0, 0x0) runsc/boot/debug.go:26 +0x38 reflect.Value.call(0xc00039a8a0, 0xc0003ac198, 0x13, 0x1255f53, 0x4, 0xc0001e7e78, 0x3, 0x3, 0x10bd701, 0xc0000f2140, ...) GOROOT/src/reflect/value.go:460 +0x62b reflect.Value.Call(0xc00039a8a0, 0xc0003ac198, 0x13, 0xc0001e7e78, 0x3, 0x3, 0x0, 0x244d5e8, 0x16) GOROOT/src/reflect/value.go:321 +0xd4 gvisor.dev/gvisor/pkg/urpc.(*Server).handleOne(0xc0003aa090, 0xc0003441b0, 0x0, 0x0) pkg/urpc/urpc.go:325 +0x688 gvisor.dev/gvisor/pkg/urpc.(*Server).handleRegistered(0xc0003aa090, 0xc0003441b0, 0x0, 0x0) pkg/urpc/urpc.go:420 +0x43 gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc0003aa090, 0xc0003441b0) 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(0xc00033e124) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc00033e124) GOROOT/src/sync/waitgroup.go:130 +0xb1 gvisor.dev/gvisor/pkg/sentry/kernel.(*Kernel).WaitExited(...) pkg/sentry/kernel/kernel.go:1059 gvisor.dev/gvisor/runsc/boot.(*Loader).WaitExit(0xc00037e000, 0x0, 0x0) runsc/boot/loader.go:902 +0x73 gvisor.dev/gvisor/runsc/cmd.(*Boot).Execute(0xc0001bc240, 0x13cb940, 0xc000134000, 0xc0002965a0, 0xc000242bc0, 0x2, 0x2, 0x0) runsc/cmd/boot.go:254 +0x149e github.com/google/subcommands.(*Commander).Execute(0xc00014c000, 0x13cb940, 0xc000134000, 0xc000242bc0, 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:316 +0x2c86 goroutine 19 [syscall]: os/signal.signal_recv(0x462a81) 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 20 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0x1289450, 0xc000122840, 0xc0001228a0) 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 34 [sync.Cond.Wait]: runtime.goparkunlock(...) GOROOT/src/runtime/proc.go:310 sync.runtime_notifyListWait(0xc00031e448, 0xa) GOROOT/src/runtime/sema.go:510 +0xf8 sync.(*Cond).Wait(0xc00031e438) GOROOT/src/sync/cond.go:56 +0x8e gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).findReclaimable(0xc00031e000, 0x0, 0x0, 0x0) pkg/sentry/pgalloc/pgalloc.go:1090 +0xbb gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).runReclaim(0xc00031e000) pkg/sentry/pgalloc/pgalloc.go:1019 +0x7b created by gvisor.dev/gvisor/pkg/sentry/pgalloc.NewMemoryFile pkg/sentry/pgalloc/pgalloc.go:330 +0x2f4 goroutine 36 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater.func1(0xc0003120c0, 0xc00033e0a0) 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 37 [chan receive]: gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).waitForStart(0xc00032c280) pkg/sentry/watchdog/watchdog.go:216 +0x9b created by gvisor.dev/gvisor/pkg/sentry/watchdog.New pkg/sentry/watchdog/watchdog.go:168 +0x334 goroutine 50 [select]: reflect.rselect(0xc0002a0000, 0x22, 0x22, 0xc0002a0000, 0x1aaea00) GOROOT/src/runtime/select.go:542 +0x3bd reflect.Select(0xc0003d4000, 0x22, 0x49, 0x0, 0x1118e40, 0x244d5e8, 0x99, 0x0) GOROOT/src/reflect/value.go:2229 +0x1f0 gvisor.dev/gvisor/pkg/sentry/sighandling.handleSignals(0xc0003a4000, 0x21, 0x40, 0xc00037c090, 0xc0003363c0, 0xc000336420, 0xc000336480) pkg/sentry/sighandling/sighandling.go:46 +0x46c created by gvisor.dev/gvisor/pkg/sentry/sighandling.PrepareHandler pkg/sentry/sighandling/sighandling.go:131 +0x29d goroutine 51 [syscall]: syscall.Syscall6(0x10f, 0xc0003e2e68, 0x2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:44 +0x5 gvisor.dev/gvisor/pkg/unet.(*Socket).wait(0xc0003aa000, 0xffffffffffffff00, 0x0, 0x0) pkg/unet/unet_unsafe.go:55 +0xda gvisor.dev/gvisor/pkg/unet.(*ServerSocket).Accept(0xc0003ac000, 0x0, 0x0, 0x0) pkg/unet/unet.go:539 +0x189 gvisor.dev/gvisor/pkg/control/server.(*Server).serve(0xc0003a8020) pkg/control/server/server.go:99 +0x50 gvisor.dev/gvisor/pkg/control/server.(*Server).StartServing.func1(0xc0003a8020) 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 32 [syscall]: syscall.Syscall6(0x119, 0x12, 0xc0003e1ae0, 0x64, 0xffffffffffffffff, 0x0, 0x0, 0xc00013f488, 0x4645ec, 0x474baf) src/syscall/asm_linux_amd64.s:44 +0x5 gvisor.dev/gvisor/pkg/fdnotifier.epollWait(0x12, 0xc0003e1ae0, 0x64, 0x64, 0xffffffffffffffff, 0x1, 0x0, 0x0) pkg/fdnotifier/poll_unsafe.go:77 +0x83 gvisor.dev/gvisor/pkg/fdnotifier.(*notifier).waitAndNotify(0xc00013f480, 0x0, 0xf7eda0) pkg/fdnotifier/fdnotifier.go:149 +0x9e created by gvisor.dev/gvisor/pkg/fdnotifier.newNotifier pkg/fdnotifier/fdnotifier.go:64 +0x114 goroutine 33 [syscall]: syscall.Syscall6(0x10f, 0xc000496090, 0x1, 0x0, 0x0, 0x0, 0x0, 0x200, 0x1aad678, 0x7f142c641ca8) src/syscall/asm_linux_amd64.s:44 +0x5 golang.org/x/sys/unix.ppoll(0xc000496090, 0x1, 0x0, 0x0, 0xc000496090, 0x10, 0x101000000000028) external/org_golang_x_sys/unix/zsyscall_linux_amd64.go:79 +0xa2 golang.org/x/sys/unix.Ppoll(0xc000496090, 0x1, 0x1, 0x0, 0x0, 0x0, 0x0, 0x448f80) external/org_golang_x_sys/unix/syscall_linux.go:133 +0xda gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor.func1.1(0xe51a5a, 0x8, 0x1, 0x0) runsc/boot/loader.go:710 +0x60 gvisor.dev/gvisor/runsc/specutils.RetryEintr(0xc0000ecf80, 0x8, 0x0, 0x0, 0x1) runsc/specutils/specutils.go:475 +0x39 gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor.func1(0x7ffee6458fb8, 0x30, 0xc0002aa050, 0x1, 0x1, 0xc00037e000) runsc/boot/loader.go:708 +0x25a created by gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor runsc/boot/loader.go:699 +0x7f goroutine 146 [syscall]: syscall.Syscall6(0x10f, 0xc000012720, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:44 +0x5 golang.org/x/sys/unix.ppoll(0xc000012720, 0x1, 0x0, 0x0, 0x13bbda0, 0x13cfd80, 0x13bea00) external/org_golang_x_sys/unix/zsyscall_linux_amd64.go:79 +0xa2 golang.org/x/sys/unix.Ppoll(0xc000012720, 0x1, 0x1, 0x0, 0x0, 0x0, 0x13ba460, 0x0) external/org_golang_x_sys/unix/syscall_linux.go:133 +0xda gvisor.dev/gvisor/pkg/p9.(*Client).watch(0xc0001f4100, 0xc000260900) pkg/p9/client.go:251 +0xda created by gvisor.dev/gvisor/pkg/p9.NewClient pkg/p9/client.go:231 +0x75e goroutine 147 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001bc360) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 148 [select]: gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).loop(0xc00032c280) pkg/sentry/watchdog/watchdog.go:232 +0x149 created by gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).Start pkg/sentry/watchdog/watchdog.go:191 +0x315 goroutine 149 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001bc3f0) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 150 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc000236000, 0xc000122fc0, 0x0, 0x69470b, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc000236000, 0xc000122fc0, 0x13ccd00, 0x0, 0x392f1e8, 0x1ed600, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc000236000, 0x0, 0xc420009c01, 0x392f1e8, 0x0, 0xffffffff, 0xf7ed00, 0x7f1418461cb8, 0xc000334900) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc000236000, 0x392f1e8, 0x0, 0x0, 0x0, 0x0, 0x0, 0x20f8, 0xc0001ed948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc000236000, 0xca, 0x392f1e8, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc000236000, 0xca, 0x392f1e8, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc000310690) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc000236000, 0xca, 0x392f1e8, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0001edce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc000236000, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc000236000, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc000236000, 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(0xc0002de000) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 132 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0000f2020, 0xc0003ae180, 0xc0003ae1e0) 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 100 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc00053a000, 0xc000176ea0, 0x0, 0xc0003d57e0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00053a000, 0xc000176ea0, 0x13ccd00, 0x0, 0xc420248148, 0x312100, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00053a000, 0x0, 0x1, 0xc420248148, 0x100, 0xffffffff, 0x0, 0x0, 0x8) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00053a000, 0xc420248148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fc9, 0xc0004f1948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00053a000, 0xca, 0xc420248148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00053a000, 0xca, 0xc420248148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0005801e0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00053a000, 0xca, 0xc420248148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004f1ce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00053a000, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00053a000, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc00053a000, 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 68 [semacquire]: sync.runtime_Semacquire(0xc00040aeb8) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc00040aeb0) 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(0xc00037e000, 0xc00040a800, 0x30) runsc/boot/loader.go:890 +0x43 gvisor.dev/gvisor/runsc/boot.(*Loader).waitContainer(0xc00037e000, 0xc00059e060, 0x30, 0xc0005860e0, 0x0, 0xc000582210) runsc/boot/loader.go:845 +0x1af gvisor.dev/gvisor/runsc/boot.(*containerManager).Wait(0xc0003a8040, 0xc000590080, 0xc0005860e0, 0x0, 0x0) runsc/boot/controller.go:424 +0xb9 reflect.Value.call(0xc00039a7e0, 0xc0003ac158, 0x13, 0x1255f53, 0x4, 0xc000555e78, 0x3, 0x3, 0x10ba701, 0xc0005860e0, ...) GOROOT/src/reflect/value.go:460 +0x62b reflect.Value.Call(0xc00039a7e0, 0xc0003ac158, 0x13, 0xc000555e78, 0x3, 0x3, 0x0, 0xc0003a8040, 0x16) GOROOT/src/reflect/value.go:321 +0xd4 gvisor.dev/gvisor/pkg/urpc.(*Server).handleOne(0xc0003aa090, 0xc00057a030, 0x0, 0x0) pkg/urpc/urpc.go:325 +0x688 gvisor.dev/gvisor/pkg/urpc.(*Server).handleRegistered(0xc0003aa090, 0xc00057a030, 0x0, 0x0) pkg/urpc/urpc.go:420 +0x43 gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc0003aa090, 0xc00057a030) pkg/urpc/urpc.go:440 +0x81 created by gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling pkg/urpc/urpc.go:438 +0x6f goroutine 151 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0000d4000, 0xc0003ae3c0, 0xc000336000, 0x0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc0000d4000, 0xc0003ae3c0, 0xc0000d4801, 0xe4423343b, 0x0, 0xc000228bc8) pkg/sentry/kernel/task_block.go:79 +0xda gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0000d4000, 0xc0003ae3c0, 0x13ccd01, 0xdf8475800, 0x392e430, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:41 +0x11d gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0000d4000, 0xdf8475800, 0x0, 0x392e430, 0x0, 0xffffffff, 0xae0803, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0000d4000, 0x392e430, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x1fc9, 0xc000171948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0000d4000, 0xca, 0x392e430, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0000d4000, 0xca, 0x392e430, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x13babc0, 0xc0005801e0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0000d4000, 0xca, 0x392e430, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc000171ce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0000d4000, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0000d4000, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0000d4000, 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 69 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0002de090) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 152 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0000d4a80, 0xc0003ae660, 0x0, 0x4645ec, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0000d4a80, 0xc0003ae660, 0x13ccd00, 0x0, 0xc4200ca548, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0000d4a80, 0x0, 0xc0000d4a01, 0xc4200ca548, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0000d4a80, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fd0, 0xc000559948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0000d4a80, 0xca, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0000d4a80, 0xca, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0003105a0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0000d4a80, 0xca, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000559ce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0000d4a80, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0000d4a80, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0000d4a80, 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 133 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0003a0000) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 153 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0000d5500, 0xc0003ae900, 0x0, 0x4645ec, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0000d5500, 0xc0003ae900, 0x13ccd00, 0x0, 0x394d0c0, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0000d5500, 0x0, 0xc0000d5501, 0x394d0c0, 0x200d0100, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0000d5500, 0x394d0c0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fcb, 0xc00016d948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0000d5500, 0xca, 0x394d0c0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0000d5500, 0xca, 0x394d0c0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0003102d0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0000d5500, 0xca, 0x394d0c0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00016dce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0000d5500, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0000d5500, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0000d5500, 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 154 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001bc000) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 155 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0001a4000, 0xc0003aee40, 0x0, 0x4645ec, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0001a4000, 0xc0003aee40, 0x13ccd00, 0x0, 0xc4200cb948, 0x0, 0x7f14ffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0001a4000, 0x0, 0xc0001a4001, 0xc4200cb948, 0x2c186000, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0001a4000, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fe4, 0xc00055b948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0001a4000, 0xca, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0001a4000, 0xca, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0005ec000) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0001a4000, 0xca, 0xc4200cb948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00055bce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0001a4000, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0001a4000, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0001a4000, 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 156 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001bc480) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 70 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0001fe000, 0xc000336780, 0x0, 0x0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0001fe000, 0xc000336780, 0x13ccd00, 0x0, 0xc42020c148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0001fe000, 0x0, 0xc0001fe001, 0xc42020c148, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0001fe000, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fcb, 0xc00016b948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0001fe000, 0xca, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0001fe000, 0xca, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0003102d0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0001fe000, 0xca, 0xc42020c148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00016bce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0001fe000, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0001fe000, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0001fe000, 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 165 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00037c120) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 160 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0001a5500, 0xc0003afec0, 0x0, 0x4645ec, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0001a5500, 0xc0003afec0, 0x13ccd00, 0x0, 0xc420482148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0001a5500, 0x0, 0xc0001a5501, 0xc420482148, 0x20490100, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0001a5500, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fc8, 0xc0005d1948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0001a5500, 0xca, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0001a5500, 0xca, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0005800f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0001a5500, 0xca, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0005d1ce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0001a5500, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0001a5500, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0001a5500, 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 78 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0005e2000, 0xc000337e60, 0x0, 0xc0003d57e0, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0005e2000, 0xc000337e60, 0x13ccd00, 0x0, 0xc420482548, 0x3b9100, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0005e2000, 0x0, 0x1, 0xc420482548, 0x20210100, 0xffffffff, 0x0, 0x0, 0x8) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0005e2000, 0xc420482548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fc8, 0xc0003d1948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0005e2000, 0xca, 0xc420482548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0005e2000, 0xca, 0xc420482548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0005800f0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0005e2000, 0xca, 0xc420482548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003d1ce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0005e2000, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0005e2000, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0005e2000, 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 74 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0002de6c0) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 161 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0005d4000, 0xc0005d2120, 0x0, 0xc0003cf5d8, 0x0) pkg/sentry/kernel/task_block.go:136 +0x178 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0005d4000, 0xc0005d2120, 0x13ccd00, 0x0, 0xc4204b4148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:36 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0005d4000, 0x0, 0xc0005d4001, 0xc4204b4148, 0x20480100, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0005d4000, 0xc4204b4148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1fd0, 0xc0003cf948, 0x40000002, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0005d4000, 0xca, 0xc4204b4148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x12548e0, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x403 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0005d4000, 0xca, 0xc4204b4148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x13babc0, 0xc0003105a0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0005d4000, 0xca, 0xc4204b4148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003cfce8, 0xe1dcf5) pkg/sentry/kernel/task_syscall.go:244 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0005d4000, 0x2, 0xc000106000) pkg/sentry/kernel/task_syscall.go:219 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0005d4000, 0x13babc0, 0x0) pkg/sentry/kernel/task_run.go:219 +0x153a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0005d4000, 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 105 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000552510) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 104 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000552480) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 166 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00037c1b0) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x246 goroutine 80 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0000f2000, 0xc0005d2180, 0xc0005d21e0) 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 193 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc00056e1f0, 0xc000669860, 0xc0006698c0) 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 110 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc0006c45b0, 0xc0003aeae0, 0xc0003aeba0) 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 291 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc00056e200, 0xc000669aa0, 0xc000669b00) 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 I1202 13:49:08.436093 8444 x:0] Exiting with status: 0 D1202 13:49:08.418051 7940 x:0] urpc: unmarshal success. D1202 13:49:08.418219 7940 x:0] containerManager.Signal &{CID:ci-gvisor-ptrace-direct-overlay-host-race-test-2 Signo:0 PID:0 Mode:Process} D1202 13:49:08.418384 7940 x:0] urpc: successfully marshalled 37 bytes. D1202 13:49:08.420129 7940 x:0] urpc: unmarshal success. D1202 13:49:08.423558 7940 x:0] urpc: successfully marshalled 32027 bytes. D1202 13:49:08.468880 7940 x:0] Clock(Monotonic): error: 125 ns, adjusted frequency from 2299806038 Hz to 2299806306 Hz D1202 13:49:08.469172 7940 x:0] Clock(Realtime): error: 166 ns, adjusted frequency from 2299806258 Hz to 2299806367 Hz D1202 13:49:08.469248 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397416298948782 monotonicBaseRef:4003741433 monotonicFrequency:2299806306 realtimeReady:1 realtimeBaseCycles:39397416299682580 realtimeBaseRef:1575294548469163049 realtimeFrequency:2299806367} D1202 13:49:09.465374 7940 x:0] Clock(Monotonic): error: -52 ns, adjusted frequency from 2299806306 Hz to 2299805906 Hz D1202 13:49:09.465517 7940 x:0] Clock(Realtime): error: 28 ns, adjusted frequency from 2299806367 Hz to 2299806086 Hz D1202 13:49:09.465586 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397418590713299 monotonicBaseRef:5000244708 monotonicFrequency:2299805906 realtimeReady:1 realtimeBaseCycles:39397418591092103 realtimeBaseRef:1575294549465511939 realtimeFrequency:2299806086} D1202 13:49:10.465390 7940 x:0] Clock(Monotonic): error: 116 ns, adjusted frequency from 2299805906 Hz to 2299806302 Hz D1202 13:49:10.465536 7940 x:0] Clock(Realtime): error: 53 ns, adjusted frequency from 2299806086 Hz to 2299806150 Hz D1202 13:49:10.465665 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397420890582260 monotonicBaseRef:6000272125 monotonicFrequency:2299806302 realtimeReady:1 realtimeBaseCycles:39397420890940288 realtimeBaseRef:1575294550465530244 realtimeFrequency:2299806150} D1202 13:49:11.465386 7940 x:0] Clock(Monotonic): error: -13 ns, adjusted frequency from 2299806302 Hz to 2299806012 Hz D1202 13:49:11.465529 7940 x:0] Clock(Realtime): error: -40 ns, adjusted frequency from 2299806150 Hz to 2299805933 Hz D1202 13:49:11.465642 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397423190382740 monotonicBaseRef:7000269593 monotonicFrequency:2299806012 realtimeReady:1 realtimeBaseCycles:39397423190732380 realtimeBaseRef:1575294551465524131 realtimeFrequency:2299805933} D1202 13:49:12.465436 7940 x:0] Clock(Monotonic): error: 57 ns, adjusted frequency from 2299806012 Hz to 2299806189 Hz D1202 13:49:12.465621 7940 x:0] Clock(Realtime): error: 114 ns, adjusted frequency from 2299805933 Hz to 2299806312 Hz D1202 13:49:12.465703 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397425490249584 monotonicBaseRef:8000296043 monotonicFrequency:2299806189 realtimeReady:1 realtimeBaseCycles:39397425490746133 realtimeBaseRef:1575294552465614495 realtimeFrequency:2299806312} D1202 13:49:13.465469 7940 x:0] Clock(Monotonic): error: 39 ns, adjusted frequency from 2299806189 Hz to 2299806146 Hz D1202 13:49:13.465646 7940 x:0] Clock(Realtime): error: -37 ns, adjusted frequency from 2299806312 Hz to 2299805954 Hz D1202 13:49:13.465739 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397427790167048 monotonicBaseRef:9000344427 monotonicFrequency:2299806146 realtimeReady:1 realtimeBaseCycles:39397427790612061 realtimeBaseRef:1575294553465640417 realtimeFrequency:2299805954} D1202 13:49:14.465442 7940 x:0] Clock(Monotonic): error: 81 ns, adjusted frequency from 2299806146 Hz to 2299806274 Hz D1202 13:49:14.465631 7940 x:0] Clock(Realtime): error: 0 ns, adjusted frequency from 2299805954 Hz to 2299806064 Hz D1202 13:49:14.465716 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397430089917542 monotonicBaseRef:10000320228 monotonicFrequency:2299806274 realtimeReady:1 realtimeBaseCycles:39397430090378260 realtimeBaseRef:1575294554465623130 realtimeFrequency:2299806064} D1202 13:49:15.465471 7940 x:0] Clock(Monotonic): error: -81 ns, adjusted frequency from 2299806274 Hz to 2299805877 Hz D1202 13:49:15.465657 7940 x:0] Clock(Realtime): error: 84 ns, adjusted frequency from 2299806064 Hz to 2299806278 Hz D1202 13:49:15.465777 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397432389738345 monotonicBaseRef:11000326545 monotonicFrequency:2299805877 realtimeReady:1 realtimeBaseCycles:39397432390246467 realtimeBaseRef:1575294555465650150 realtimeFrequency:2299806278} D1202 13:49:16.465494 7940 x:0] Clock(Monotonic): error: 52 ns, adjusted frequency from 2299805877 Hz to 2299806220 Hz D1202 13:49:16.465668 7940 x:0] Clock(Realtime): error: -122 ns, adjusted frequency from 2299806278 Hz to 2299805806 Hz D1202 13:49:16.465746 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397434689622460 monotonicBaseRef:12000360564 monotonicFrequency:2299806220 realtimeReady:1 realtimeBaseCycles:39397434690072344 realtimeBaseRef:1575294556465658672 realtimeFrequency:2299805806} D1202 13:49:17.465475 7940 x:0] Clock(Monotonic): error: 6 ns, adjusted frequency from 2299806220 Hz to 2299806102 Hz D1202 13:49:17.465654 7940 x:0] Clock(Realtime): error: 127 ns, adjusted frequency from 2299805806 Hz to 2299806391 Hz D1202 13:49:17.465757 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397436989391454 monotonicBaseRef:13000344377 monotonicFrequency:2299806102 realtimeReady:1 realtimeBaseCycles:39397436989853485 realtimeBaseRef:1575294557465647947 realtimeFrequency:2299806391} D1202 13:49:18.465499 7940 x:0] Clock(Monotonic): error: -32 ns, adjusted frequency from 2299806102 Hz to 2299806017 Hz D1202 13:49:18.465665 7940 x:0] Clock(Realtime): error: -30 ns, adjusted frequency from 2299806391 Hz to 2299805996 Hz D1202 13:49:18.465759 7940 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:39397439289240563 monotonicBaseRef:14000363077 monotonicFrequency:2299806017 realtimeReady:1 realtimeBaseCycles:39397439289684486 realtimeBaseRef:1575294558465658647 realtimeFrequency:2299805996}