I0304 15:31:49.848157 35353 main.go:305] *************************** I0304 15:31:49.848401 35353 main.go:306] Args: [/syzkaller/managers/ptrace-direct-overlay-host-race/current/image -root /syzkaller/managers/ptrace-direct-overlay-host-race/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-0 /syz-fuzzer -executor=/syz-executor -name=vm-0 -arch=amd64 -manager=stdin -sandbox=none -procs=4 -cover=false -debug=false -test=false] I0304 15:31:49.850028 35353 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0304 15:31:49.850167 35353 main.go:308] PID: 35353 I0304 15:31:49.850284 35353 main.go:309] UID: 0, GID: 0 I0304 15:31:49.850414 35353 main.go:310] Configuration: I0304 15:31:49.850515 35353 main.go:311] RootDir: /syzkaller/managers/ptrace-direct-overlay-host-race/workdir/gvisor_root I0304 15:31:49.850626 35353 main.go:312] Platform: ptrace I0304 15:31:49.850880 35353 main.go:313] FileAccess: exclusive, overlay: true I0304 15:31:49.851085 35353 main.go:314] Network: host, logging: false I0304 15:31:49.851222 35353 main.go:315] Strace: false, max size: 1024, syscalls: [] I0304 15:31:49.851338 35353 main.go:316] *************************** W0304 15:31:49.851470 35353 main.go:321] Block the TERM signal. This is only safe in tests! D0304 15:31:49.855384 35353 container.go:159] Load container "/syzkaller/managers/ptrace-direct-overlay-host-race/workdir/gvisor_root" "ci-gvisor-ptrace-direct-overlay-host-race-0" D0304 15:31:49.883279 35353 container.go:592] Signal container "ci-gvisor-ptrace-direct-overlay-host-race-0": signal 0 D0304 15:31:49.883532 35353 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-direct-overlay-host-race-0" D0304 15:31:49.883684 35353 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-0" I0304 15:31:49.885692 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:49.885668 35353 urpc.go:534] urpc: successfully marshalled 123 bytes. D0304 15:31:49.885952 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:49.886071 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.886204 34871 task_block.go:223] [ 1] Interrupt queued I0304 15:31:49.886254 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:49.886441 34871 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0304 15:31:49.886727 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:49.886921 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:49.887441 34871 urpc.go:577] urpc: unmarshal success. D0304 15:31:49.887804 34871 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-direct-overlay-host-race-0 Signo:0 PID:0 Mode:Process} D0304 15:31:49.888226 34871 urpc.go:534] urpc: successfully marshalled 37 bytes. D0304 15:31:49.888556 35353 urpc.go:577] urpc: unmarshal success. D0304 15:31:49.888799 35353 exec.go:120] Exec arguments: /syz-fuzzer -executor=/syz-executor -name=vm-0 -arch=amd64 -manager=stdin -sandbox=none -procs=4 -cover=false -debug=false -test=false D0304 15:31:49.888938 35353 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0304 15:31:49.889229 35353 container.go:533] Execute in container "ci-gvisor-ptrace-direct-overlay-host-race-0", args: /syz-fuzzer -executor=/syz-executor -name=vm-0 -arch=amd64 -manager=stdin -sandbox=none -procs=4 -cover=false -debug=false -test=false D0304 15:31:49.889500 35353 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-direct-overlay-host-race-0" in sandbox "ci-gvisor-ptrace-direct-overlay-host-race-0" D0304 15:31:49.889722 35353 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-0" D0304 15:31:49.890895 35353 urpc.go:534] urpc: successfully marshalled 601 bytes. D0304 15:31:49.891440 34871 urpc.go:577] urpc: unmarshal success. D0304 15:31:49.892898 34871 controller.go:267] containerManager.ExecuteAsync: /syz-fuzzer -executor=/syz-executor -name=vm-0 -arch=amd64 -manager=stdin -sandbox=none -procs=4 -cover=false -debug=false -test=false I0304 15:31:49.898172 34871 kernel.go:797] EXEC: [/syz-fuzzer -executor=/syz-executor -name=vm-0 -arch=amd64 -manager=stdin -sandbox=none -procs=4 -cover=false -debug=false -test=false] I0304 15:31:49.902754 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:49.914431 34871 transport_flipcall.go:127] send [channel @0xc0001e0300] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-fuzzer]} D0304 15:31:49.917100 34871 transport_flipcall.go:234] recv [channel @0xc0001e0300] 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: 28035744, BlockSize: 4096, Blocks: 54760, ATime: {Sec: 1582836029, NanoSec: 577321195}, MTime: {Sec: 1582836029, NanoSec: 577321195}, CTime: {Sec: 1583335909, NanoSec: 580570528}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 55050277}]} D0304 15:31:49.917413 34871 transport_flipcall.go:127] send [channel @0xc0001e0300] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-fuzzer, Size: 1} D0304 15:31:49.917956 34871 transport_flipcall.go:234] recv [channel @0xc0001e0300] Rlerror{Error: 95} D0304 15:31:49.918341 34871 transport_flipcall.go:127] send [channel @0xc0001e0300] Twalk{FID: 5, NewFID: 6, Names: []} D0304 15:31:49.919105 34871 transport_flipcall.go:234] recv [channel @0xc0001e0300] Rwalk{QIDs: []} D0304 15:31:49.919329 34871 transport_flipcall.go:127] send [channel @0xc0001e0300] Tlopen{FID: 6, Flags: ReadOnly} D0304 15:31:49.921101 34871 transport_flipcall.go:234] recv [channel @0xc0001e0300] Rlopen{QID: QID{Type: 0, Version: 0, Path: 55050277}, IoUnit: 0, File: &{{39}}} D0304 15:31:49.932464 34871 syscalls.go:266] Allocating stack with size of 8388608 bytes D0304 15:31:49.935447 34871 loader.go:832] updated processes: map[{ci-gvisor-ptrace-direct-overlay-host-race-0 0}:0xc00040e1e0 {ci-gvisor-ptrace-direct-overlay-host-race-0 30}:0xc00013c9a0] D0304 15:31:49.935949 34871 urpc.go:534] urpc: successfully marshalled 37 bytes. D0304 15:31:49.936028 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:49.936207 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.936181 35353 urpc.go:577] urpc: unmarshal success. D0304 15:31:49.936414 34871 task_block.go:223] [ 1] Interrupt queued I0304 15:31:49.936393 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:49.936390 35353 container.go:580] Wait on PID 30 in container "ci-gvisor-ptrace-direct-overlay-host-race-0" D0304 15:31:49.936588 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:49.936537 35353 sandbox.go:761] Waiting for PID 30 in sandbox "ci-gvisor-ptrace-direct-overlay-host-race-0" D0304 15:31:49.936600 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:49.936700 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.936725 35353 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-direct-overlay-host-race-0" D0304 15:31:49.936780 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:49.937180 35353 urpc.go:534] urpc: successfully marshalled 106 bytes. D0304 15:31:49.937256 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:49.937333 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:49.937422 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.937515 34871 urpc.go:577] urpc: unmarshal success. D0304 15:31:49.937605 34871 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0304 15:31:49.937724 34871 task_signals.go:220] [ 2] Signal 23: delivering to handler D0304 15:31:49.937825 34871 controller.go:443] containerManager.Wait D0304 15:31:49.944059 34871 task_block.go:223] [ 30] Interrupt queued I0304 15:31:49.951194 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:49.951540 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:49.951690 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.951740 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.951981 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:49.952154 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler I0304 15:31:49.971189 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:49.971443 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:49.971613 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.971641 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:49.971914 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:49.972104 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler I0304 15:31:50.001262 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:50.001460 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:50.001553 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.001744 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.002009 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:50.002215 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:50.171120 34871 parameters.go:238] Clock(Monotonic): error: -343 ns, adjusted frequency from 2299775804 Hz to 2299773663 Hz D0304 15:31:50.172176 34871 parameters.go:238] Clock(Realtime): error: 148 ns, adjusted frequency from 2299775366 Hz to 2299774843 Hz D0304 15:31:50.172351 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723108882471372 monotonicBaseRef:3000317732 monotonicFrequency:2299773663 realtimeReady:1 realtimeBaseCycles:9723108884919284 realtimeBaseRef:1583335910172165894 realtimeFrequency:2299774843} I0304 15:31:50.201241 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:50.201463 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:50.201619 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.201782 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.202006 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:50.202248 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler I0304 15:31:50.253102 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:50.253442 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:50.253622 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.253754 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.253983 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:50.254146 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:50.256173 34871 task_signals.go:446] [ 30] Notified of signal 7 D0304 15:31:50.256338 34871 task_block.go:223] [ 30] Interrupt queued D0304 15:31:50.256479 34871 task_signals.go:189] [ 30] Signal 7: terminating thread group I0304 15:31:50.256660 34871 compat.go:129] Uncaught signal: "bus error" (7), PID: 30, TID: 30, fault addr: 0x1ebeed0 D0304 15:31:50.256926 34871 task_exit.go:221] [ 30] Transitioning from exit state TaskExitNone to TaskExitInitiated I0304 15:31:50.267247 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:50.267418 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:50.267578 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.267605 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.267841 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:50.268026 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler I0304 15:31:50.280019 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:50.280164 34871 task_exit.go:221] [ 30] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0304 15:31:50.280390 34871 task_exit.go:221] [ 30] Transitioning from exit state TaskExitZombie to TaskExitDead D0304 15:31:50.280637 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:50.280800 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.281001 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.281321 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:50.281517 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:50.282241 34871 loader.go:867] updated processes (removal): map[{ci-gvisor-ptrace-direct-overlay-host-race-0 0}:0xc00040e1e0] D0304 15:31:50.295343 34871 urpc.go:534] urpc: successfully marshalled 36 bytes. D0304 15:31:50.297176 35353 urpc.go:577] urpc: unmarshal success. I0304 15:31:50.300589 35353 main.go:329] Exiting with status: 7 DIAGNOSIS: Error collecting stacks: failed to run ["/syzkaller/managers/ptrace-direct-overlay-host-race/current/image" "-root" "/syzkaller/managers/ptrace-direct-overlay-host-race/workdir/gvisor_root" "-watchdog-action=panic" "-network=none" "-debug" "-alsologtostderr" "-platform=ptrace" "-file-access=exclusive" "-overlay" "-network=host" "-TESTONLY-unsafe-nonroot" "debug" "-stacks" "--ps" "ci-gvisor-ptrace-direct-overlay-host-race-0"]: signal: segmentation faultI0304 15:31:50.530332 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:50.530591 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:50.530769 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.530819 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:50.531028 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:50.531194 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:51.171819 34871 parameters.go:238] Clock(Monotonic): error: 598 ns, adjusted frequency from 2299773663 Hz to 2299775788 Hz D0304 15:31:51.172025 34871 parameters.go:238] Clock(Realtime): error: -55 ns, adjusted frequency from 2299774843 Hz to 2299774291 Hz D0304 15:31:51.172140 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723111182177217 monotonicBaseRef:4000288243 monotonicFrequency:2299775788 realtimeReady:1 realtimeBaseCycles:9723111184358218 realtimeBaseRef:1583335911172019832 realtimeFrequency:2299774291} D0304 15:31:52.171032 34871 parameters.go:238] Clock(Monotonic): error: -479 ns, adjusted frequency from 2299775788 Hz to 2299773388 Hz D0304 15:31:52.171236 34871 parameters.go:238] Clock(Realtime): error: 75 ns, adjusted frequency from 2299774291 Hz to 2299774576 Hz D0304 15:31:52.171318 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723113481832601 monotonicBaseRef:5000235888 monotonicFrequency:2299773388 realtimeReady:1 realtimeBaseCycles:9723113482320624 realtimeBaseRef:1583335912171231978 realtimeFrequency:2299774576} I0304 15:31:52.452045 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:52.452293 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:52.452461 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:52.452495 34871 task_block.go:223] [ 1] Interrupt queued I0304 15:31:52.452663 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:52.452721 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:52.452793 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:52.452916 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:52.452906 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:52.453352 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:52.453398 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:52.453466 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:52.453629 34871 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0304 15:31:52.453798 34871 task_signals.go:220] [ 2] Signal 23: delivering to handler D0304 15:31:53.171133 34871 parameters.go:238] Clock(Monotonic): error: 531 ns, adjusted frequency from 2299773388 Hz to 2299775652 Hz I0304 15:31:53.171282 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:53.171354 34871 parameters.go:238] Clock(Realtime): error: 161 ns, adjusted frequency from 2299774576 Hz to 2299774783 Hz D0304 15:31:53.171501 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:53.171493 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723115781826350 monotonicBaseRef:6000331706 monotonicFrequency:2299775652 realtimeReady:1 realtimeBaseCycles:9723115782360263 realtimeBaseRef:1583335913171347234 realtimeFrequency:2299774783} D0304 15:31:53.171666 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:53.171720 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:53.171980 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:53.172135 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:54.170993 34871 parameters.go:238] Clock(Monotonic): error: -69 ns, adjusted frequency from 2299775652 Hz to 2299774310 Hz D0304 15:31:54.171145 34871 parameters.go:238] Clock(Realtime): error: 45 ns, adjusted frequency from 2299774783 Hz to 2299774614 Hz D0304 15:31:54.171244 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723118081296266 monotonicBaseRef:7000198764 monotonicFrequency:2299774310 realtimeReady:1 realtimeBaseCycles:9723118081661764 realtimeBaseRef:1583335914171141439 realtimeFrequency:2299774614} D0304 15:31:55.171090 34871 parameters.go:238] Clock(Monotonic): error: -202 ns, adjusted frequency from 2299774310 Hz to 2299774083 Hz D0304 15:31:55.171342 34871 parameters.go:238] Clock(Realtime): error: 277 ns, adjusted frequency from 2299774614 Hz to 2299775103 Hz D0304 15:31:55.171485 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723120381237557 monotonicBaseRef:8000271371 monotonicFrequency:2299774083 realtimeReady:1 realtimeBaseCycles:9723120381873904 realtimeBaseRef:1583335915171331686 realtimeFrequency:2299775103} D0304 15:31:56.171021 34871 parameters.go:238] Clock(Monotonic): error: 377 ns, adjusted frequency from 2299774083 Hz to 2299775357 Hz D0304 15:31:56.171188 34871 parameters.go:238] Clock(Realtime): error: -188 ns, adjusted frequency from 2299775103 Hz to 2299774092 Hz D0304 15:31:56.171314 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723122680904271 monotonicBaseRef:9000224684 monotonicFrequency:2299775357 realtimeReady:1 realtimeBaseCycles:9723122681308004 realtimeBaseRef:1583335916171183409 realtimeFrequency:2299774092} I0304 15:31:56.451701 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:56.451911 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:56.452041 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:56.452099 34871 task_block.go:223] [ 1] Interrupt queued I0304 15:31:56.452212 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:56.452339 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:56.452397 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:56.452472 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:56.452532 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:56.452983 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:56.453016 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:56.453092 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:56.453280 34871 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0304 15:31:56.453424 34871 task_signals.go:220] [ 2] Signal 23: delivering to handler D0304 15:31:57.171046 34871 parameters.go:238] Clock(Monotonic): error: -189 ns, adjusted frequency from 2299775357 Hz to 2299774177 Hz D0304 15:31:57.171302 34871 parameters.go:238] Clock(Realtime): error: 319 ns, adjusted frequency from 2299774092 Hz to 2299775283 Hz D0304 15:31:57.171467 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723124980733248 monotonicBaseRef:10000247999 monotonicFrequency:2299774177 realtimeReady:1 realtimeBaseCycles:9723124981341021 realtimeBaseRef:1583335917171295996 realtimeFrequency:2299775283} I0304 15:31:57.451702 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:57.451876 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:57.451999 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:57.452102 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:57.452241 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:57.452323 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:58.171044 34871 parameters.go:238] Clock(Monotonic): error: 217 ns, adjusted frequency from 2299774177 Hz to 2299774973 Hz I0304 15:31:58.171162 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:58.171199 34871 parameters.go:238] Clock(Realtime): error: -315 ns, adjusted frequency from 2299775283 Hz to 2299773862 Hz D0304 15:31:58.171326 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:58.171318 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723127280469582 monotonicBaseRef:11000231543 monotonicFrequency:2299774973 realtimeReady:1 realtimeBaseCycles:9723127280881819 realtimeBaseRef:1583335918171194036 realtimeFrequency:2299773862} D0304 15:31:58.171435 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:58.171562 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:58.171788 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:58.171976 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler I0304 15:31:58.451726 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:58.451929 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:58.452112 34871 task_block.go:223] [ 1] Interrupt queued I0304 15:31:58.452274 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:58.452433 34871 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0304 15:31:58.452373 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:58.452635 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:58.452725 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:59.171074 34871 parameters.go:238] Clock(Monotonic): error: 128 ns, adjusted frequency from 2299774973 Hz to 2299774848 Hz I0304 15:31:59.171147 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:59.171304 34871 parameters.go:238] Clock(Realtime): error: 54 ns, adjusted frequency from 2299773862 Hz to 2299774700 Hz D0304 15:31:59.171348 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:59.171447 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:59.171427 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723129580343993 monotonicBaseRef:12000274781 monotonicFrequency:2299774848 realtimeReady:1 realtimeBaseCycles:9723129580894877 realtimeBaseRef:1583335919171298044 realtimeFrequency:2299774700} D0304 15:31:59.171505 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:59.171819 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0304 15:31:59.172010 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler I0304 15:31:59.451795 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:59.451991 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:59.452096 34871 task_block.go:223] [ 1] Interrupt queued I0304 15:31:59.452186 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:59.452210 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:59.452304 34871 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0304 15:31:59.452463 34871 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0304 15:31:59.454761 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:59.452604 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:59.455658 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:59.455792 34871 task_block.go:223] [ 1] Interrupt queued I0304 15:31:59.455957 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:59.456046 34871 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0304 15:31:59.458274 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:59.458433 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:59.458542 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:59.458558 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:59.458703 34871 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0304 15:31:59.458857 34871 loader.go:566] Received external signal 23, mode: Process D0304 15:31:59.458909 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:59.459081 34871 task_signals.go:220] [ 1] Signal 23: delivering to handler D0304 15:31:59.459106 34871 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal D0304 15:31:59.459146 34871 task_signals.go:446] [ 1] Notified of signal 23 D0304 15:31:59.459294 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:59.459496 34871 task_block.go:223] [ 2] Interrupt queued D0304 15:31:59.459591 34871 task_block.go:223] [ 1] Interrupt queued D0304 15:31:59.459899 34871 task_signals.go:220] [ 2] Signal 23: delivering to handler D0304 15:32:00.171049 34871 parameters.go:238] Clock(Monotonic): error: 235 ns, adjusted frequency from 2299774848 Hz to 2299775126 Hz D0304 15:32:00.171368 34871 parameters.go:238] Clock(Realtime): error: 389 ns, adjusted frequency from 2299774700 Hz to 2299775484 Hz D0304 15:32:00.171478 34871 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9723131880058570 monotonicBaseRef:13000248573 monotonicFrequency:2299775126 realtimeReady:1 realtimeBaseCycles:9723131880814497 realtimeBaseRef:1583335920171361058 realtimeFrequency:2299775484}