D0303 02:18:18.421510 2043 parameters.go:238] Clock(Monotonic): error: 374 ns, adjusted frequency from 2299773766 Hz to 2299774791 Hz D0303 02:18:18.421907 2043 parameters.go:238] Clock(Realtime): error: 265 ns, adjusted frequency from 2299773689 Hz to 2299774688 Hz D0303 02:18:18.422425 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414912061264503 monotonicBaseRef:2000445036 monotonicFrequency:2299774791 realtimeReady:1 realtimeBaseCycles:9414912062235861 realtimeBaseRef:1583201898421902136 realtimeFrequency:2299774688} I0303 02:18:18.850536 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:18.850753 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:18.850873 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:18.851041 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:18.851211 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:18.851351 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:19.421367 2043 parameters.go:238] Clock(Monotonic): error: -115 ns, adjusted frequency from 2299774791 Hz to 2299774141 Hz D0303 02:18:19.421585 2043 parameters.go:238] Clock(Realtime): error: 348 ns, adjusted frequency from 2299774688 Hz to 2299775110 Hz D0303 02:18:19.421721 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414914360737525 monotonicBaseRef:3000313819 monotonicFrequency:2299774141 realtimeReady:1 realtimeBaseCycles:9414914361272039 realtimeBaseRef:1583201899421581013 realtimeFrequency:2299775110} I0303 02:18:19.850707 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:19.850998 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:19.851176 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:19.851413 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:19.851352 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:19.851609 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:18:19.851853 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:19.852033 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:19.861561 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:19.861761 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:19.861924 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:19.862075 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:19.862412 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:19.862606 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:20.421917 2043 parameters.go:238] Clock(Monotonic): error: 191 ns, adjusted frequency from 2299774141 Hz to 2299774885 Hz D0303 02:18:20.422134 2043 parameters.go:238] Clock(Realtime): error: 23 ns, adjusted frequency from 2299775110 Hz to 2299774422 Hz D0303 02:18:20.422575 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414916661736603 monotonicBaseRef:4000846452 monotonicFrequency:2299774885 realtimeReady:1 realtimeBaseCycles:9414916662297580 realtimeBaseRef:1583201900422124731 realtimeFrequency:2299774422} I0303 02:18:20.851594 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:20.851966 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:20.852138 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:20.852286 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:20.852554 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:20.852707 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:21.422104 2043 parameters.go:238] Clock(Monotonic): error: -18 ns, adjusted frequency from 2299774885 Hz to 2299774458 Hz D0303 02:18:21.422414 2043 parameters.go:238] Clock(Realtime): error: 224 ns, adjusted frequency from 2299774422 Hz to 2299774945 Hz D0303 02:18:21.422606 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414918961981662 monotonicBaseRef:5001050895 monotonicFrequency:2299774458 realtimeReady:1 realtimeBaseCycles:9414918962725349 realtimeBaseRef:1583201901422408822 realtimeFrequency:2299774945} D0303 02:18:22.421367 2043 parameters.go:238] Clock(Monotonic): error: 391 ns, adjusted frequency from 2299774458 Hz to 2299775454 Hz D0303 02:18:22.421608 2043 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0303 02:18:22.421743 2043 parameters.go:238] Clock(Realtime): error: 280 ns, adjusted frequency from 2299774945 Hz to 2299775075 Hz D0303 02:18:22.421948 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414921260055067 monotonicBaseRef:6000311234 monotonicFrequency:2299775454 realtimeReady:1 realtimeBaseCycles:9414921260952954 realtimeBaseRef:1583201902421735999 realtimeFrequency:2299775075} I0303 02:18:22.851594 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:22.852976 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:22.853091 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:22.853234 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:22.853203 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:22.853335 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:18:22.853487 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:22.853667 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:23.421378 2043 parameters.go:238] Clock(Monotonic): error: -220 ns, adjusted frequency from 2299775454 Hz to 2299774015 Hz D0303 02:18:23.421643 2043 parameters.go:238] Clock(Realtime): error: 204 ns, adjusted frequency from 2299775075 Hz to 2299774880 Hz D0303 02:18:23.421756 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414923559864361 monotonicBaseRef:7000325948 monotonicFrequency:2299774015 realtimeReady:1 realtimeBaseCycles:9414923560498781 realtimeBaseRef:1583201903421636316 realtimeFrequency:2299774880} D0303 02:18:24.421346 2043 parameters.go:238] Clock(Monotonic): error: 25 ns, adjusted frequency from 2299774015 Hz to 2299774589 Hz D0303 02:18:24.421549 2043 parameters.go:238] Clock(Realtime): error: 51 ns, adjusted frequency from 2299774880 Hz to 2299774526 Hz D0303 02:18:24.421714 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414925859507535 monotonicBaseRef:8000269055 monotonicFrequency:2299774589 realtimeReady:1 realtimeBaseCycles:9414925860056997 realtimeBaseRef:1583201904421542105 realtimeFrequency:2299774526} D0303 02:18:25.421277 2043 parameters.go:238] Clock(Monotonic): error: 160 ns, adjusted frequency from 2299774589 Hz to 2299774748 Hz D0303 02:18:25.421444 2043 parameters.go:238] Clock(Realtime): error: -140 ns, adjusted frequency from 2299774526 Hz to 2299774137 Hz D0303 02:18:25.421553 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414928159132662 monotonicBaseRef:9000204065 monotonicFrequency:2299774748 realtimeReady:1 realtimeBaseCycles:9414928159596699 realtimeBaseRef:1583201905421439997 realtimeFrequency:2299774137} I0303 02:18:25.850564 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:25.850866 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:25.850981 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:25.851172 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:25.851368 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:25.851496 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:26.421363 2043 parameters.go:238] Clock(Monotonic): error: 169 ns, adjusted frequency from 2299774748 Hz to 2299774919 Hz D0303 02:18:26.421571 2043 parameters.go:238] Clock(Realtime): error: 96 ns, adjusted frequency from 2299774137 Hz to 2299774781 Hz D0303 02:18:26.421687 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414930459150297 monotonicBaseRef:10000309678 monotonicFrequency:2299774919 realtimeReady:1 realtimeBaseCycles:9414930459661463 realtimeBaseRef:1583201906421566368 realtimeFrequency:2299774781} I0303 02:18:26.850479 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:26.850726 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:26.850855 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:26.851294 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:26.851546 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:26.851664 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:26.861508 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:26.861767 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:26.861917 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:26.861935 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:26.862213 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:26.862384 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:27.421385 2043 parameters.go:238] Clock(Monotonic): error: 21 ns, adjusted frequency from 2299774919 Hz to 2299774611 Hz I0303 02:18:27.421607 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:27.421635 2043 parameters.go:238] Clock(Realtime): error: 52 ns, adjusted frequency from 2299774781 Hz to 2299774686 Hz D0303 02:18:27.421877 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:27.422037 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.422078 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:27.422199 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:27.421873 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414932758948676 monotonicBaseRef:11000319878 monotonicFrequency:2299774611 realtimeReady:1 realtimeBaseCycles:9414932759578959 realtimeBaseRef:1583201907421628424 realtimeFrequency:2299774686} D0303 02:18:27.422365 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:27.422378 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:27.422489 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:27.422528 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.423109 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:27.423237 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.423235 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:27.423570 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.423722 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:27.423822 2043 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0303 02:18:27.861400 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:27.861634 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:27.861893 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.861779 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.862857 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:27.863013 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:27.931276 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:27.931575 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:27.931695 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.931821 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:27.932078 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:27.932223 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:28.421368 2043 parameters.go:238] Clock(Monotonic): error: 231 ns, adjusted frequency from 2299774611 Hz to 2299775041 Hz I0303 02:18:28.421528 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:28.421637 2043 parameters.go:238] Clock(Realtime): error: 236 ns, adjusted frequency from 2299774686 Hz to 2299775107 Hz D0303 02:18:28.421786 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:28.421801 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414935058698387 monotonicBaseRef:12000309050 monotonicFrequency:2299775041 realtimeReady:1 realtimeBaseCycles:9414935059355365 realtimeBaseRef:1583201908421629171 realtimeFrequency:2299775107} D0303 02:18:28.421953 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:28.422011 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:28.422301 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:28.422401 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:28.851429 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:28.851711 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:28.851894 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:28.851922 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:28.852079 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:28.852168 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:28.852247 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:28.852307 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:28.852367 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:28.852792 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:28.852911 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:28.853261 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:28.853490 2043 task_signals.go:176] [ 2] Not restarting syscall 270 after errno 514: interrupted by signal 23 D0303 02:18:28.853661 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:29.421353 2043 parameters.go:238] Clock(Monotonic): error: -442 ns, adjusted frequency from 2299775041 Hz to 2299773602 Hz D0303 02:18:29.421604 2043 parameters.go:238] Clock(Realtime): error: -137 ns, adjusted frequency from 2299775107 Hz to 2299774217 Hz D0303 02:18:29.421718 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414937358450282 monotonicBaseRef:13000298985 monotonicFrequency:2299773602 realtimeReady:1 realtimeBaseCycles:9414937359059812 realtimeBaseRef:1583201909421598446 realtimeFrequency:2299774217} I0303 02:18:29.852039 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:29.852353 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:29.852546 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:29.852701 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:29.852711 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:29.852948 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:29.853061 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:29.853072 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:29.853292 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:29.853628 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:29.853751 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:29.853887 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:30.421305 2043 parameters.go:238] Clock(Monotonic): error: 199 ns, adjusted frequency from 2299773602 Hz to 2299775052 Hz I0303 02:18:30.421430 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:30.421608 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:30.421568 2043 parameters.go:238] Clock(Realtime): error: 226 ns, adjusted frequency from 2299774217 Hz to 2299775042 Hz D0303 02:18:30.421751 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:30.421790 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414939658046152 monotonicBaseRef:14000221702 monotonicFrequency:2299775052 realtimeReady:1 realtimeBaseCycles:9414939658747130 realtimeBaseRef:1583201910421560660 realtimeFrequency:2299775042} D0303 02:18:30.421840 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:30.421972 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:30.422174 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:30.422308 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:30.422274 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:30.422437 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:30.422830 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:30.422860 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:30.422959 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:30.423147 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:30.423293 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:31.421285 2043 parameters.go:238] Clock(Monotonic): error: -37 ns, adjusted frequency from 2299775052 Hz to 2299774508 Hz D0303 02:18:31.421488 2043 parameters.go:238] Clock(Realtime): error: -135 ns, adjusted frequency from 2299775042 Hz to 2299774263 Hz D0303 02:18:31.421637 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414941957840237 monotonicBaseRef:15000229978 monotonicFrequency:2299774508 realtimeReady:1 realtimeBaseCycles:9414941958344564 realtimeBaseRef:1583201911421483431 realtimeFrequency:2299774263} I0303 02:18:32.271503 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:32.271736 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:32.271924 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:32.272012 2043 urpc.go:577] urpc: unmarshal success. D0303 02:18:32.271973 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:32.272094 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:32.272256 2043 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-1 Signo:0 PID:0 Mode:Process} D0303 02:18:32.272337 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:32.272371 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:32.272489 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:32.272540 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:32.272846 2043 urpc.go:534] urpc: successfully marshalled 37 bytes. D0303 02:18:32.273018 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:32.273169 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:32.273166 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:32.273519 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:32.273681 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:32.421371 2043 parameters.go:238] Clock(Monotonic): error: -189 ns, adjusted frequency from 2299774508 Hz to 2299774178 Hz D0303 02:18:32.421623 2043 parameters.go:238] Clock(Realtime): error: 87 ns, adjusted frequency from 2299774263 Hz to 2299774770 Hz I0303 02:18:32.421589 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:32.421785 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414944257758151 monotonicBaseRef:16000292334 monotonicFrequency:2299774178 realtimeReady:1 realtimeBaseCycles:9414944258422368 realtimeBaseRef:1583201912421615418 realtimeFrequency:2299774770} D0303 02:18:32.421946 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:32.422146 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:32.422302 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:32.422206 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:32.422435 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:18:32.422643 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:32.422866 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:32.851176 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:32.851444 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:32.851597 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:32.851647 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:32.851957 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:32.852108 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:33.421570 2043 parameters.go:238] Clock(Monotonic): error: 430 ns, adjusted frequency from 2299774178 Hz to 2299775490 Hz D0303 02:18:33.421768 2043 parameters.go:238] Clock(Realtime): error: -4 ns, adjusted frequency from 2299774770 Hz to 2299774582 Hz D0303 02:18:33.421864 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414946558056892 monotonicBaseRef:17000520427 monotonicFrequency:2299775490 realtimeReady:1 realtimeBaseCycles:9414946558534985 realtimeBaseRef:1583201913421762322 realtimeFrequency:2299774582} I0303 02:18:33.851516 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:33.851774 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:33.851952 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:33.852074 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:33.852248 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:33.852384 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:34.421337 2043 parameters.go:238] Clock(Monotonic): error: -263 ns, adjusted frequency from 2299775490 Hz to 2299774159 Hz D0303 02:18:34.421635 2043 parameters.go:238] Clock(Realtime): error: -227 ns, adjusted frequency from 2299774582 Hz to 2299774139 Hz D0303 02:18:34.421771 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414948857280030 monotonicBaseRef:18000280250 monotonicFrequency:2299774159 realtimeReady:1 realtimeBaseCycles:9414948857996403 realtimeBaseRef:1583201914421626150 realtimeFrequency:2299774139} D0303 02:18:35.421306 2043 parameters.go:238] Clock(Monotonic): error: -29 ns, adjusted frequency from 2299774159 Hz to 2299774653 Hz D0303 02:18:35.421537 2043 parameters.go:238] Clock(Realtime): error: 121 ns, adjusted frequency from 2299774139 Hz to 2299774849 Hz D0303 02:18:35.421689 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414951156993759 monotonicBaseRef:19000253973 monotonicFrequency:2299774653 realtimeReady:1 realtimeBaseCycles:9414951157554060 realtimeBaseRef:1583201915421532018 realtimeFrequency:2299774849} I0303 02:18:35.850592 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:35.850894 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:35.851030 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:35.851176 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:35.851160 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:35.851301 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:18:35.851418 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:35.851545 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:35.861504 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:35.861718 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:35.861910 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:35.862049 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:35.862304 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:35.862485 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:36.421397 2043 parameters.go:238] Clock(Monotonic): error: -91 ns, adjusted frequency from 2299774653 Hz to 2299774527 Hz D0303 02:18:36.421629 2043 parameters.go:238] Clock(Realtime): error: 491 ns, adjusted frequency from 2299774849 Hz to 2299775761 Hz D0303 02:18:36.421764 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414953456968652 monotonicBaseRef:20000341042 monotonicFrequency:2299774527 realtimeReady:1 realtimeBaseCycles:9414953457538790 realtimeBaseRef:1583201916421623279 realtimeFrequency:2299775761} I0303 02:18:36.852201 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:36.852434 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:36.852562 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:36.852712 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:36.852991 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:36.853190 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:36.856034 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:36.856741 2043 task_signals.go:452] [ 2] Notified of group signal 23 D0303 02:18:36.856947 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:36.857010 2043 task_block.go:223] [ 2] Interrupt queued I0303 02:18:36.857166 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:36.857089 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:36.859100 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:36.859154 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:36.859243 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:36.859169 2043 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0303 02:18:36.859393 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:36.859511 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:18:36.859732 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:36.859853 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:36.859963 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:36.860254 2043 task_signals.go:176] [ 2] Not restarting syscall 219 after errno 516: interrupted by signal 23 D0303 02:18:36.860390 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:37.421362 2043 parameters.go:238] Clock(Monotonic): error: -173 ns, adjusted frequency from 2299774527 Hz to 2299774296 Hz D0303 02:18:37.421616 2043 parameters.go:238] Clock(Realtime): error: -460 ns, adjusted frequency from 2299775761 Hz to 2299773548 Hz D0303 02:18:37.421749 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414955756658946 monotonicBaseRef:21000304415 monotonicFrequency:2299774296 realtimeReady:1 realtimeBaseCycles:9414955757282843 realtimeBaseRef:1583201917421609491 realtimeFrequency:2299773548} I0303 02:18:37.850898 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:37.851096 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:37.851203 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:37.851302 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:37.851533 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:37.851673 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:37.931151 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:37.931342 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:37.931449 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:37.931488 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:37.931585 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:37.931675 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:37.931773 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:37.931854 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:37.931892 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:37.932397 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:37.932558 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:37.932572 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:37.932812 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:37.932934 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:38.422386 2043 parameters.go:238] Clock(Monotonic): error: 327 ns, adjusted frequency from 2299774296 Hz to 2299775362 Hz D0303 02:18:38.422623 2043 parameters.go:238] Clock(Realtime): error: 27 ns, adjusted frequency from 2299773548 Hz to 2299774661 Hz D0303 02:18:38.422827 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414958058779822 monotonicBaseRef:22001324767 monotonicFrequency:2299775362 realtimeReady:1 realtimeBaseCycles:9414958059342910 realtimeBaseRef:1583201918422603727 realtimeFrequency:2299774661} I0303 02:18:38.850782 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:38.851049 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:38.851253 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:38.851283 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:38.851426 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:38.851542 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:38.851562 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:38.851812 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:38.852687 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:38.853332 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:38.853497 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:38.853718 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:38.853968 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:38.854157 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:39.421357 2043 parameters.go:238] Clock(Monotonic): error: 211 ns, adjusted frequency from 2299775362 Hz to 2299775010 Hz I0303 02:18:39.421556 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:39.421602 2043 parameters.go:238] Clock(Realtime): error: 73 ns, adjusted frequency from 2299774661 Hz to 2299774802 Hz D0303 02:18:39.421822 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:39.421938 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:39.421922 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414960356199875 monotonicBaseRef:23000300619 monotonicFrequency:2299775010 realtimeReady:1 realtimeBaseCycles:9414960356796940 realtimeBaseRef:1583201919421594658 realtimeFrequency:2299774802} D0303 02:18:39.422029 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:39.422144 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:39.422305 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:18:39.422531 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:39.422689 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:40.421314 2043 parameters.go:238] Clock(Monotonic): error: -389 ns, adjusted frequency from 2299775010 Hz to 2299773693 Hz D0303 02:18:40.421573 2043 parameters.go:238] Clock(Realtime): error: -19 ns, adjusted frequency from 2299774802 Hz to 2299774507 Hz D0303 02:18:40.421727 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414962655874272 monotonicBaseRef:24000256869 monotonicFrequency:2299773693 realtimeReady:1 realtimeBaseCycles:9414962656503804 realtimeBaseRef:1583201920421565116 realtimeFrequency:2299774507} D0303 02:18:41.421346 2043 parameters.go:238] Clock(Monotonic): error: -114 ns, adjusted frequency from 2299773693 Hz to 2299774346 Hz D0303 02:18:41.421554 2043 parameters.go:238] Clock(Realtime): error: -101 ns, adjusted frequency from 2299774507 Hz to 2299774416 Hz D0303 02:18:41.421689 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414964955734667 monotonicBaseRef:25000294569 monotonicFrequency:2299774346 realtimeReady:1 realtimeBaseCycles:9414964956241222 realtimeBaseRef:1583201921421548988 realtimeFrequency:2299774416} D0303 02:18:42.421307 2043 parameters.go:238] Clock(Monotonic): error: 249 ns, adjusted frequency from 2299774346 Hz to 2299775125 Hz D0303 02:18:42.421504 2043 parameters.go:238] Clock(Realtime): error: -118 ns, adjusted frequency from 2299774416 Hz to 2299774382 Hz D0303 02:18:42.421653 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414967255387826 monotonicBaseRef:26000241873 monotonicFrequency:2299775125 realtimeReady:1 realtimeBaseCycles:9414967255901702 realtimeBaseRef:1583201922421499445 realtimeFrequency:2299774382} D0303 02:18:43.421978 2043 parameters.go:238] Clock(Monotonic): error: -83 ns, adjusted frequency from 2299775125 Hz to 2299774433 Hz D0303 02:18:43.422204 2043 parameters.go:238] Clock(Realtime): error: 144 ns, adjusted frequency from 2299774382 Hz to 2299774873 Hz D0303 02:18:43.422410 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414969556729181 monotonicBaseRef:27000922909 monotonicFrequency:2299774433 realtimeReady:1 realtimeBaseCycles:9414969557282749 realtimeBaseRef:1583201923422198063 realtimeFrequency:2299774873} D0303 02:18:44.421330 2043 parameters.go:238] Clock(Monotonic): error: 147 ns, adjusted frequency from 2299774433 Hz to 2299774972 Hz D0303 02:18:44.421559 2043 parameters.go:238] Clock(Realtime): error: 558 ns, adjusted frequency from 2299774873 Hz to 2299775972 Hz D0303 02:18:44.421709 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414971855009451 monotonicBaseRef:28000273209 monotonicFrequency:2299774972 realtimeReady:1 realtimeBaseCycles:9414971855573770 realtimeBaseRef:1583201924421552846 realtimeFrequency:2299775972} I0303 02:18:44.850949 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:44.851169 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:44.851297 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:44.851339 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:44.851571 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:44.851692 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:45.421335 2043 parameters.go:238] Clock(Monotonic): error: -322 ns, adjusted frequency from 2299774972 Hz to 2299773868 Hz I0303 02:18:45.421475 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:45.421581 2043 parameters.go:238] Clock(Realtime): error: -857 ns, adjusted frequency from 2299775972 Hz to 2299772669 Hz D0303 02:18:45.421705 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414974154755377 monotonicBaseRef:29000260579 monotonicFrequency:2299773868 realtimeReady:1 realtimeBaseCycles:9414974155397474 realtimeBaseRef:1583201925421573601 realtimeFrequency:2299772669} D0303 02:18:45.421760 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:45.421978 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:45.422069 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:45.422290 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:45.422439 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:46.421307 2043 parameters.go:238] Clock(Monotonic): error: 522 ns, adjusted frequency from 2299773868 Hz to 2299775727 Hz D0303 02:18:46.421555 2043 parameters.go:238] Clock(Realtime): error: 371 ns, adjusted frequency from 2299772669 Hz to 2299775469 Hz D0303 02:18:46.421708 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414976454509283 monotonicBaseRef:30000251899 monotonicFrequency:2299775727 realtimeReady:1 realtimeBaseCycles:9414976455113378 realtimeBaseRef:1583201926421548918 realtimeFrequency:2299775469} I0303 02:18:46.851107 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:46.851395 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:46.851555 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:46.851573 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:46.851721 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:46.851835 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:46.851903 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:46.852042 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:46.852144 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:46.852551 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:46.852742 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:46.853009 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:46.853149 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:46.853303 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:46.853377 2043 task_run.go:155] [ 2] Restarting syscall 270 after errno 514: not interrupted by handled signal D0303 02:18:47.421350 2043 parameters.go:238] Clock(Monotonic): error: -401 ns, adjusted frequency from 2299775727 Hz to 2299773657 Hz D0303 02:18:47.421633 2043 parameters.go:238] Clock(Realtime): error: 153 ns, adjusted frequency from 2299775469 Hz to 2299774991 Hz D0303 02:18:47.421822 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414978754383701 monotonicBaseRef:31000294812 monotonicFrequency:2299773657 realtimeReady:1 realtimeBaseCycles:9414978755065984 realtimeBaseRef:1583201927421625941 realtimeFrequency:2299774991} I0303 02:18:47.931316 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:47.931640 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:47.931843 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:47.931813 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:47.932918 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:47.933001 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:47.933086 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:47.933180 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:47.933223 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:47.933631 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:47.933747 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:47.933710 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:47.933942 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:47.934045 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:48.421290 2043 parameters.go:238] Clock(Monotonic): error: 233 ns, adjusted frequency from 2299773657 Hz to 2299775099 Hz I0303 02:18:48.421434 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:48.421587 2043 parameters.go:238] Clock(Realtime): error: -34 ns, adjusted frequency from 2299774991 Hz to 2299774495 Hz D0303 02:18:48.421659 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:48.421805 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:48.421741 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414981054010487 monotonicBaseRef:32000230948 monotonicFrequency:2299775099 realtimeReady:1 realtimeBaseCycles:9414981054731901 realtimeBaseRef:1583201928421578512 realtimeFrequency:2299774495} D0303 02:18:48.421844 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:48.421976 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:48.422132 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:48.422165 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:48.422248 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:48.422275 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:48.422663 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:48.422758 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:48.422706 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:48.422943 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:48.423061 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler I0303 02:18:48.850681 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:48.850917 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:48.851110 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:48.851180 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:48.851278 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:48.851396 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:48.851461 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:48.851555 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:48.851606 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:48.852042 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:48.852202 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:48.852481 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:48.852669 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:48.852831 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:49.421356 2043 parameters.go:238] Clock(Monotonic): error: -196 ns, adjusted frequency from 2299775099 Hz to 2299774164 Hz D0303 02:18:49.421583 2043 parameters.go:238] Clock(Realtime): error: 15 ns, adjusted frequency from 2299774495 Hz to 2299774710 Hz D0303 02:18:49.421728 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414983353933164 monotonicBaseRef:33000295118 monotonicFrequency:2299774164 realtimeReady:1 realtimeBaseCycles:9414983354501852 realtimeBaseRef:1583201929421576536 realtimeFrequency:2299774710} I0303 02:18:49.422052 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:49.422434 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:49.422569 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:49.422630 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:49.422710 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:49.422943 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:49.422932 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:49.423100 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:49.423124 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:49.423712 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:49.423871 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:49.423861 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:49.424100 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:49.424219 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:18:50.421661 2043 parameters.go:238] Clock(Monotonic): error: -45 ns, adjusted frequency from 2299774164 Hz to 2299774509 Hz D0303 02:18:50.421894 2043 parameters.go:238] Clock(Realtime): error: -332 ns, adjusted frequency from 2299774710 Hz to 2299773856 Hz D0303 02:18:50.422007 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414985654427314 monotonicBaseRef:34000608186 monotonicFrequency:2299774509 realtimeReady:1 realtimeBaseCycles:9414985654994708 realtimeBaseRef:1583201930421888803 realtimeFrequency:2299773856} I0303 02:18:50.422475 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:50.422742 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:50.422994 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:50.423276 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:50.423578 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:50.423734 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:51.421534 2043 parameters.go:238] Clock(Monotonic): error: 302 ns, adjusted frequency from 2299774509 Hz to 2299775341 Hz D0303 02:18:51.421745 2043 parameters.go:238] Clock(Realtime): error: 156 ns, adjusted frequency from 2299773856 Hz to 2299774969 Hz D0303 02:18:51.421876 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414987953907997 monotonicBaseRef:35000480423 monotonicFrequency:2299775341 realtimeReady:1 realtimeBaseCycles:9414987954423655 realtimeBaseRef:1583201931421738827 realtimeFrequency:2299774969} D0303 02:18:52.421378 2043 parameters.go:238] Clock(Monotonic): error: -387 ns, adjusted frequency from 2299775341 Hz to 2299773707 Hz D0303 02:18:52.421579 2043 parameters.go:238] Clock(Realtime): error: -79 ns, adjusted frequency from 2299774969 Hz to 2299774425 Hz D0303 02:18:52.421725 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414990253297046 monotonicBaseRef:36000312453 monotonicFrequency:2299773707 realtimeReady:1 realtimeBaseCycles:9414990253816333 realtimeBaseRef:1583201932421572597 realtimeFrequency:2299774425} D0303 02:18:53.421611 2043 parameters.go:238] Clock(Monotonic): error: 22 ns, adjusted frequency from 2299773707 Hz to 2299774620 Hz D0303 02:18:53.421805 2043 parameters.go:238] Clock(Realtime): error: -112 ns, adjusted frequency from 2299774425 Hz to 2299774275 Hz D0303 02:18:53.421923 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414992553628586 monotonicBaseRef:37000555012 monotonicFrequency:2299774620 realtimeReady:1 realtimeBaseCycles:9414992554113054 realtimeBaseRef:1583201933421799704 realtimeFrequency:2299774275} I0303 02:18:53.851217 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:53.851439 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:53.851536 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:53.851688 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:53.851847 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:53.851959 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:53.861409 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:53.861621 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:53.861763 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:53.861823 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:53.862722 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:53.862859 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:54.421380 2043 parameters.go:238] Clock(Monotonic): error: 134 ns, adjusted frequency from 2299774620 Hz to 2299774920 Hz D0303 02:18:54.421614 2043 parameters.go:238] Clock(Realtime): error: 277 ns, adjusted frequency from 2299774275 Hz to 2299775199 Hz D0303 02:18:54.421739 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414994852877668 monotonicBaseRef:38000326494 monotonicFrequency:2299774920 realtimeReady:1 realtimeBaseCycles:9414994853443086 realtimeBaseRef:1583201934421606535 realtimeFrequency:2299775199} I0303 02:18:54.850533 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:54.850815 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:54.850978 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:54.851028 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:54.851210 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:54.851341 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:18:54.861521 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:54.861795 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:54.861937 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:54.862081 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:54.862350 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:54.862486 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:55.422343 2043 parameters.go:238] Clock(Monotonic): error: -16 ns, adjusted frequency from 2299774920 Hz to 2299774675 Hz D0303 02:18:55.422565 2043 parameters.go:238] Clock(Realtime): error: -51 ns, adjusted frequency from 2299775199 Hz to 2299774448 Hz D0303 02:18:55.422719 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414997154859182 monotonicBaseRef:39001285976 monotonicFrequency:2299774675 realtimeReady:1 realtimeBaseCycles:9414997155406305 realtimeBaseRef:1583201935422557941 realtimeFrequency:2299774448} D0303 02:18:56.422257 2043 parameters.go:238] Clock(Monotonic): error: 22 ns, adjusted frequency from 2299774675 Hz to 2299774690 Hz D0303 02:18:56.422508 2043 parameters.go:238] Clock(Realtime): error: 175 ns, adjusted frequency from 2299774448 Hz to 2299775035 Hz D0303 02:18:56.422668 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9414999454433135 monotonicBaseRef:40001198697 monotonicFrequency:2299774690 realtimeReady:1 realtimeBaseCycles:9414999455051146 realtimeBaseRef:1583201936422501584 realtimeFrequency:2299775035} I0303 02:18:56.861494 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:56.861717 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:56.861863 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:56.862005 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:56.862194 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:56.862311 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:57.422169 2043 parameters.go:238] Clock(Monotonic): error: -73 ns, adjusted frequency from 2299774690 Hz to 2299774566 Hz D0303 02:18:57.422461 2043 parameters.go:238] Clock(Realtime): error: -65 ns, adjusted frequency from 2299775035 Hz to 2299774498 Hz D0303 02:18:57.422606 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415001754012308 monotonicBaseRef:41001113681 monotonicFrequency:2299774566 realtimeReady:1 realtimeBaseCycles:9415001754714096 realtimeBaseRef:1583201937422452846 realtimeFrequency:2299774498} I0303 02:18:57.422663 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:57.423023 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:57.423188 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:57.423244 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:57.423488 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:57.423599 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:58.422410 2043 parameters.go:238] Clock(Monotonic): error: -154 ns, adjusted frequency from 2299774566 Hz to 2299774251 Hz D0303 02:18:58.422629 2043 parameters.go:238] Clock(Realtime): error: -159 ns, adjusted frequency from 2299774498 Hz to 2299774250 Hz D0303 02:18:58.422782 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415004054339780 monotonicBaseRef:42001354098 monotonicFrequency:2299774251 realtimeReady:1 realtimeBaseCycles:9415004054882175 realtimeBaseRef:1583201938422623984 realtimeFrequency:2299774250} D0303 02:18:59.422677 2043 parameters.go:238] Clock(Monotonic): error: 390 ns, adjusted frequency from 2299774251 Hz to 2299775380 Hz D0303 02:18:59.422966 2043 parameters.go:238] Clock(Realtime): error: 33 ns, adjusted frequency from 2299774250 Hz to 2299774689 Hz D0303 02:18:59.423111 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415006354728700 monotonicBaseRef:43001621371 monotonicFrequency:2299775380 realtimeReady:1 realtimeBaseCycles:9415006355430860 realtimeBaseRef:1583201939422960727 realtimeFrequency:2299774689} I0303 02:18:59.851551 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:59.851800 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:59.851926 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:59.852060 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:18:59.852217 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:18:59.852336 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:18:59.852427 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:18:59.852476 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:18:59.852518 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:59.852918 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:59.852972 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:18:59.853072 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:18:59.853219 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:18:59.853380 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:00.421308 2043 parameters.go:238] Clock(Monotonic): error: -175 ns, adjusted frequency from 2299775380 Hz to 2299774302 Hz D0303 02:19:00.421522 2043 parameters.go:238] Clock(Realtime): error: -76 ns, adjusted frequency from 2299774689 Hz to 2299774412 Hz D0303 02:19:00.421646 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415008651353944 monotonicBaseRef:44000251612 monotonicFrequency:2299774302 realtimeReady:1 realtimeBaseCycles:9415008651883913 realtimeBaseRef:1583201940421516395 realtimeFrequency:2299774412} D0303 02:19:01.421363 2043 parameters.go:238] Clock(Monotonic): error: -133 ns, adjusted frequency from 2299774302 Hz to 2299774286 Hz D0303 02:19:01.421653 2043 parameters.go:238] Clock(Realtime): error: 103 ns, adjusted frequency from 2299774412 Hz to 2299774872 Hz D0303 02:19:01.421781 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415010951256962 monotonicBaseRef:45000307580 monotonicFrequency:2299774286 realtimeReady:1 realtimeBaseCycles:9415010951942394 realtimeBaseRef:1583201941421639915 realtimeFrequency:2299774872} I0303 02:19:01.644932 2043 watchdog.go:277] Watchdog starting loop, tasks: 17, discount: 0s D0303 02:19:02.421458 2043 parameters.go:238] Clock(Monotonic): error: 208 ns, adjusted frequency from 2299774286 Hz to 2299775110 Hz D0303 02:19:02.422177 2043 parameters.go:238] Clock(Realtime): error: -140 ns, adjusted frequency from 2299774872 Hz to 2299774378 Hz D0303 02:19:02.422352 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415013251177162 monotonicBaseRef:46000371027 monotonicFrequency:2299775110 realtimeReady:1 realtimeBaseCycles:9415013252925414 realtimeBaseRef:1583201942422165248 realtimeFrequency:2299774378} D0303 02:19:03.421381 2043 parameters.go:238] Clock(Monotonic): error: -107 ns, adjusted frequency from 2299775110 Hz to 2299774190 Hz D0303 02:19:03.421570 2043 parameters.go:238] Clock(Realtime): error: -186 ns, adjusted frequency from 2299774378 Hz to 2299774167 Hz D0303 02:19:03.421677 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415015550859170 monotonicBaseRef:47000330543 monotonicFrequency:2299774190 realtimeReady:1 realtimeBaseCycles:9415015551321848 realtimeBaseRef:1583201943421566083 realtimeFrequency:2299774167} D0303 02:19:04.421315 2043 parameters.go:238] Clock(Monotonic): error: 289 ns, adjusted frequency from 2299774190 Hz to 2299775144 Hz D0303 02:19:04.421614 2043 parameters.go:238] Clock(Realtime): error: 297 ns, adjusted frequency from 2299774167 Hz to 2299775339 Hz I0303 02:19:04.421528 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:04.421732 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415017850470352 monotonicBaseRef:48000259662 monotonicFrequency:2299775144 realtimeReady:1 realtimeBaseCycles:9415017851189252 realtimeBaseRef:1583201944421606624 realtimeFrequency:2299775339} D0303 02:19:04.421827 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:04.421927 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:04.422076 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:04.422067 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:04.422211 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:04.422371 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:04.422568 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:05.421372 2043 parameters.go:238] Clock(Monotonic): error: -243 ns, adjusted frequency from 2299775144 Hz to 2299774052 Hz I0303 02:19:05.421606 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:05.421712 2043 parameters.go:238] Clock(Realtime): error: -301 ns, adjusted frequency from 2299775339 Hz to 2299773946 Hz D0303 02:19:05.421826 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:05.421936 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:05.422084 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:05.422180 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:05.422072 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:05.422492 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:05.422702 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:05.423089 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415020150374449 monotonicBaseRef:49000315734 monotonicFrequency:2299774052 realtimeReady:1 realtimeBaseCycles:9415020151184202 realtimeBaseRef:1583201945421702116 realtimeFrequency:2299773946} D0303 02:19:06.421359 2043 parameters.go:238] Clock(Monotonic): error: 380 ns, adjusted frequency from 2299774052 Hz to 2299775380 Hz D0303 02:19:06.421637 2043 parameters.go:238] Clock(Realtime): error: -118 ns, adjusted frequency from 2299773946 Hz to 2299774384 Hz D0303 02:19:06.421778 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415022450122534 monotonicBaseRef:50000304442 monotonicFrequency:2299775380 realtimeReady:1 realtimeBaseCycles:9415022450793332 realtimeBaseRef:1583201946421630449 realtimeFrequency:2299774384} I0303 02:19:06.851445 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:06.851745 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:06.851949 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:06.852016 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:06.852249 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:06.852417 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:07.151969 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:07.152226 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:07.152344 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:07.152312 2043 urpc.go:577] urpc: unmarshal success. D0303 02:19:07.152449 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:07.152568 2043 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-1 Signo:0 PID:0 Mode:Process} I0303 02:19:07.152544 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:07.152941 2043 urpc.go:534] urpc: successfully marshalled 37 bytes. D0303 02:19:07.153089 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:07.153239 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:07.153325 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:07.153392 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:07.159509 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:07.159688 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:07.159914 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:07.160095 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:07.160514 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:07.160812 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:07.161752 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:07.421315 2043 parameters.go:238] Clock(Monotonic): error: 170 ns, adjusted frequency from 2299775380 Hz to 2299774930 Hz D0303 02:19:07.421589 2043 parameters.go:238] Clock(Realtime): error: 609 ns, adjusted frequency from 2299774384 Hz to 2299775983 Hz D0303 02:19:07.421801 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415024749793850 monotonicBaseRef:51000259192 monotonicFrequency:2299774930 realtimeReady:1 realtimeBaseCycles:9415024750452257 realtimeBaseRef:1583201947421580244 realtimeFrequency:2299775983} I0303 02:19:07.931589 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:07.931848 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:07.932004 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:07.932076 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:07.932190 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:07.932251 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:07.932331 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:07.932371 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:07.932443 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:07.932792 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:07.932899 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:07.933179 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:08.421630 2043 parameters.go:238] Clock(Monotonic): error: -150 ns, adjusted frequency from 2299774930 Hz to 2299774431 Hz D0303 02:19:08.421903 2043 parameters.go:238] Clock(Realtime): error: -403 ns, adjusted frequency from 2299775983 Hz to 2299773726 Hz D0303 02:19:08.422059 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415027050276242 monotonicBaseRef:52000566814 monotonicFrequency:2299774431 realtimeReady:1 realtimeBaseCycles:9415027050949225 realtimeBaseRef:1583201948421893746 realtimeFrequency:2299773726} I0303 02:19:08.852285 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:08.852880 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:08.852974 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:08.853141 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:08.853293 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:08.853391 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:08.861402 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:08.861685 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:08.861840 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:08.861999 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:08.862323 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:08.862505 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:09.421363 2043 parameters.go:238] Clock(Monotonic): error: -100 ns, adjusted frequency from 2299774431 Hz to 2299774291 Hz I0303 02:19:09.421468 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:09.421631 2043 parameters.go:238] Clock(Realtime): error: 266 ns, adjusted frequency from 2299773726 Hz to 2299775208 Hz D0303 02:19:09.421700 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:09.421834 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:09.421955 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:09.422008 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:09.422172 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:09.422201 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415029349446980 monotonicBaseRef:53000304313 monotonicFrequency:2299774291 realtimeReady:1 realtimeBaseCycles:9415029350089231 realtimeBaseRef:1583201949421618188 realtimeFrequency:2299775208} D0303 02:19:09.422406 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:09.422566 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:09.851377 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:09.851728 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:09.851874 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:09.851908 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:09.852178 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:09.852348 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:10.421239 2043 parameters.go:238] Clock(Monotonic): error: 37 ns, adjusted frequency from 2299774291 Hz to 2299774636 Hz D0303 02:19:10.421500 2043 parameters.go:238] Clock(Realtime): error: -160 ns, adjusted frequency from 2299775208 Hz to 2299774217 Hz I0303 02:19:10.421470 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:10.421629 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415031648952643 monotonicBaseRef:54000187506 monotonicFrequency:2299774636 realtimeReady:1 realtimeBaseCycles:9415031649561101 realtimeBaseRef:1583201950421486289 realtimeFrequency:2299774217} D0303 02:19:10.421727 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:10.421865 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:10.422053 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:10.422009 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:10.422262 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:10.422543 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:10.422697 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:11.421297 2043 parameters.go:238] Clock(Monotonic): error: 51 ns, adjusted frequency from 2299774636 Hz to 2299774591 Hz D0303 02:19:11.421513 2043 parameters.go:238] Clock(Realtime): error: -125 ns, adjusted frequency from 2299774217 Hz to 2299774206 Hz D0303 02:19:11.421718 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415033948856742 monotonicBaseRef:55000243799 monotonicFrequency:2299774591 realtimeReady:1 realtimeBaseCycles:9415033949379780 realtimeBaseRef:1583201951421505622 realtimeFrequency:2299774206} D0303 02:19:12.421298 2043 parameters.go:238] Clock(Monotonic): error: 102 ns, adjusted frequency from 2299774591 Hz to 2299774939 Hz D0303 02:19:12.421519 2043 parameters.go:238] Clock(Realtime): error: 28 ns, adjusted frequency from 2299774206 Hz to 2299774642 Hz I0303 02:19:12.421472 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:12.421666 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415036248627050 monotonicBaseRef:56000241936 monotonicFrequency:2299774939 realtimeReady:1 realtimeBaseCycles:9415036249169825 realtimeBaseRef:1583201952421512509 realtimeFrequency:2299774642} D0303 02:19:12.421756 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:12.421944 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:12.422019 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:12.422079 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:12.422208 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:12.422360 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:12.422484 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:12.850483 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:12.850723 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:12.850814 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:12.850943 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:12.851174 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:12.851346 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:13.421361 2043 parameters.go:238] Clock(Monotonic): error: -214 ns, adjusted frequency from 2299774939 Hz to 2299774131 Hz D0303 02:19:13.421568 2043 parameters.go:238] Clock(Realtime): error: -52 ns, adjusted frequency from 2299774642 Hz to 2299774479 Hz D0303 02:19:13.421683 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415038548561789 monotonicBaseRef:57000311421 monotonicFrequency:2299774131 realtimeReady:1 realtimeBaseCycles:9415038549061503 realtimeBaseRef:1583201953421563399 realtimeFrequency:2299774479} D0303 02:19:14.421338 2043 parameters.go:238] Clock(Monotonic): error: -212 ns, adjusted frequency from 2299774131 Hz to 2299774069 Hz D0303 02:19:14.421587 2043 parameters.go:238] Clock(Realtime): error: 363 ns, adjusted frequency from 2299774479 Hz to 2299775406 Hz D0303 02:19:14.421735 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415040848275854 monotonicBaseRef:58000285302 monotonicFrequency:2299774069 realtimeReady:1 realtimeBaseCycles:9415040848875955 realtimeBaseRef:1583201954421580780 realtimeFrequency:2299775406} D0303 02:19:15.421321 2043 parameters.go:238] Clock(Monotonic): error: 398 ns, adjusted frequency from 2299774069 Hz to 2299775556 Hz D0303 02:19:15.421506 2043 parameters.go:238] Clock(Realtime): error: -164 ns, adjusted frequency from 2299775406 Hz to 2299774185 Hz D0303 02:19:15.421641 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415043148017543 monotonicBaseRef:59000271222 monotonicFrequency:2299775556 realtimeReady:1 realtimeBaseCycles:9415043148469081 realtimeBaseRef:1583201955421501520 realtimeFrequency:2299774185} I0303 02:19:15.851410 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:15.851704 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:15.851893 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:15.852097 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:15.852308 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:15.852471 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:15.852099 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:15.852635 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:15.852756 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:15.852975 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:15.853131 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:15.852981 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:15.853379 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:15.853597 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:16.421337 2043 parameters.go:238] Clock(Monotonic): error: -457 ns, adjusted frequency from 2299775556 Hz to 2299773631 Hz D0303 02:19:16.421531 2043 parameters.go:238] Clock(Realtime): error: -2 ns, adjusted frequency from 2299774185 Hz to 2299774611 Hz I0303 02:19:16.421450 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:16.421642 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415045447784668 monotonicBaseRef:60000267555 monotonicFrequency:2299773631 realtimeReady:1 realtimeBaseCycles:9415045448300735 realtimeBaseRef:1583201956421526508 realtimeFrequency:2299774611} D0303 02:19:16.421814 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:16.421941 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:16.422077 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:16.422052 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:16.422226 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:16.422401 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:16.422584 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:16.850534 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:16.850764 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:16.850906 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:16.850942 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:16.851198 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:16.851335 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:17.421320 2043 parameters.go:238] Clock(Monotonic): error: 276 ns, adjusted frequency from 2299773631 Hz to 2299775049 Hz D0303 02:19:17.421526 2043 parameters.go:238] Clock(Realtime): error: -249 ns, adjusted frequency from 2299774611 Hz to 2299774015 Hz D0303 02:19:17.421654 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415047747564626 monotonicBaseRef:61000270306 monotonicFrequency:2299775049 realtimeReady:1 realtimeBaseCycles:9415047748060397 realtimeBaseRef:1583201957421520007 realtimeFrequency:2299774015} I0303 02:19:17.421663 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:17.421904 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:17.422097 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:17.422231 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:17.422433 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:17.422552 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:17.931196 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:17.931831 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:17.931981 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:17.932132 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:17.932097 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:17.932305 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:17.932517 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:17.932727 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:18.421408 2043 parameters.go:238] Clock(Monotonic): error: -290 ns, adjusted frequency from 2299775049 Hz to 2299774051 Hz D0303 02:19:18.421623 2043 parameters.go:238] Clock(Realtime): error: 288 ns, adjusted frequency from 2299774015 Hz to 2299775285 Hz D0303 02:19:18.421735 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415050047544068 monotonicBaseRef:62000359181 monotonicFrequency:2299774051 realtimeReady:1 realtimeBaseCycles:9415050048058652 realtimeBaseRef:1583201958421617512 realtimeFrequency:2299775285} D0303 02:19:19.421293 2043 parameters.go:238] Clock(Monotonic): error: 468 ns, adjusted frequency from 2299774051 Hz to 2299775694 Hz D0303 02:19:19.421503 2043 parameters.go:238] Clock(Realtime): error: 21 ns, adjusted frequency from 2299775285 Hz to 2299774656 Hz D0303 02:19:19.421630 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415052347054892 monotonicBaseRef:63000244723 monotonicFrequency:2299775694 realtimeReady:1 realtimeBaseCycles:9415052347557108 realtimeBaseRef:1583201959421497139 realtimeFrequency:2299774656} I0303 02:19:19.851640 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:19.851922 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:19.852026 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:19.852134 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:19.852300 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:19.852430 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:19.852417 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:19.852577 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:19.852683 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:19.852911 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:19.853048 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:19.853117 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:19.853328 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:19.853457 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:20.421770 2043 parameters.go:238] Clock(Monotonic): error: 123 ns, adjusted frequency from 2299775694 Hz to 2299774926 Hz D0303 02:19:20.422028 2043 parameters.go:238] Clock(Realtime): error: -112 ns, adjusted frequency from 2299774656 Hz to 2299774398 Hz D0303 02:19:20.422186 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415054647915440 monotonicBaseRef:64000716444 monotonicFrequency:2299774926 realtimeReady:1 realtimeBaseCycles:9415054648535919 realtimeBaseRef:1583201960422020735 realtimeFrequency:2299774398} I0303 02:19:20.850690 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:20.850952 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:20.851055 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:20.851171 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:20.851431 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0303 02:19:20.851438 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:20.851600 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:20.851741 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:20.851901 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:20.852214 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:20.852376 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:20.852453 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:20.852749 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:20.852920 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:21.421278 2043 parameters.go:238] Clock(Monotonic): error: -157 ns, adjusted frequency from 2299774926 Hz to 2299774271 Hz D0303 02:19:21.421493 2043 parameters.go:238] Clock(Realtime): error: -65 ns, adjusted frequency from 2299774398 Hz to 2299774504 Hz D0303 02:19:21.421602 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415056946568911 monotonicBaseRef:65000228807 monotonicFrequency:2299774271 realtimeReady:1 realtimeBaseCycles:9415056947083586 realtimeBaseRef:1583201961421487321 realtimeFrequency:2299774504} D0303 02:19:22.421313 2043 parameters.go:238] Clock(Monotonic): error: -22 ns, adjusted frequency from 2299774271 Hz to 2299774582 Hz D0303 02:19:22.421513 2043 parameters.go:238] Clock(Realtime): error: 15 ns, adjusted frequency from 2299774504 Hz to 2299774635 Hz D0303 02:19:22.421655 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415059246371164 monotonicBaseRef:66000240974 monotonicFrequency:2299774582 realtimeReady:1 realtimeBaseCycles:9415059246903532 realtimeBaseRef:1583201962421507080 realtimeFrequency:2299774635} I0303 02:19:22.850716 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:22.850961 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:22.851111 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:22.851147 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:22.851255 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:22.851372 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:22.851556 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:22.851701 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:23.421305 2043 parameters.go:238] Clock(Monotonic): error: -305 ns, adjusted frequency from 2299774582 Hz to 2299773956 Hz D0303 02:19:23.421507 2043 parameters.go:238] Clock(Realtime): error: 34 ns, adjusted frequency from 2299774635 Hz to 2299774687 Hz D0303 02:19:23.421628 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415061546176219 monotonicBaseRef:67000254224 monotonicFrequency:2299773956 realtimeReady:1 realtimeBaseCycles:9415061546667136 realtimeBaseRef:1583201963421502283 realtimeFrequency:2299774687} D0303 02:19:24.421346 2043 parameters.go:238] Clock(Monotonic): error: -227 ns, adjusted frequency from 2299773956 Hz to 2299774158 Hz D0303 02:19:24.421581 2043 parameters.go:238] Clock(Realtime): error: -61 ns, adjusted frequency from 2299774687 Hz to 2299774468 Hz D0303 02:19:24.421719 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415063846052289 monotonicBaseRef:68000298625 monotonicFrequency:2299774158 realtimeReady:1 realtimeBaseCycles:9415063846612411 realtimeBaseRef:1583201964421576458 realtimeFrequency:2299774468} D0303 02:19:25.421334 2043 parameters.go:238] Clock(Monotonic): error: 172 ns, adjusted frequency from 2299774158 Hz to 2299775008 Hz I0303 02:19:25.421429 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:25.421561 2043 parameters.go:238] Clock(Realtime): error: 269 ns, adjusted frequency from 2299774468 Hz to 2299775231 Hz D0303 02:19:25.421646 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:25.421765 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:25.421720 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415066145718417 monotonicBaseRef:69000251650 monotonicFrequency:2299775008 realtimeReady:1 realtimeBaseCycles:9415066146334048 realtimeBaseRef:1583201965421553485 realtimeFrequency:2299775231} D0303 02:19:25.421910 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:25.422135 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:25.422271 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:25.850520 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:25.850743 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:25.850879 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:25.851002 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:25.851138 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:25.851141 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:25.851431 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:25.851586 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:25.861406 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:25.861635 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:25.861783 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:25.861865 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:25.862221 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:25.862346 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:26.421388 2043 parameters.go:238] Clock(Monotonic): error: -27 ns, adjusted frequency from 2299775008 Hz to 2299774682 Hz I0303 02:19:26.421571 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:26.421687 2043 parameters.go:238] Clock(Realtime): error: -81 ns, adjusted frequency from 2299775231 Hz to 2299774324 Hz D0303 02:19:26.421836 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:26.421833 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415068445691767 monotonicBaseRef:70000337894 monotonicFrequency:2299774682 realtimeReady:1 realtimeBaseCycles:9415068446394542 realtimeBaseRef:1583201966421677524 realtimeFrequency:2299774324} D0303 02:19:26.421999 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:26.422062 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:26.422178 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:26.422322 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:26.422534 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:26.422729 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:27.421457 2043 parameters.go:238] Clock(Monotonic): error: -176 ns, adjusted frequency from 2299774682 Hz to 2299774201 Hz D0303 02:19:27.421684 2043 parameters.go:238] Clock(Realtime): error: -33 ns, adjusted frequency from 2299774324 Hz to 2299774510 Hz D0303 02:19:27.421798 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415070745625962 monotonicBaseRef:71000407254 monotonicFrequency:2299774201 realtimeReady:1 realtimeBaseCycles:9415070746167814 realtimeBaseRef:1583201967421677066 realtimeFrequency:2299774510} I0303 02:19:27.931239 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:27.931462 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:27.931622 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:27.931705 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:27.931983 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:27.932151 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:28.421524 2043 parameters.go:238] Clock(Monotonic): error: 305 ns, adjusted frequency from 2299774201 Hz to 2299775262 Hz D0303 02:19:28.421797 2043 parameters.go:238] Clock(Realtime): error: -23 ns, adjusted frequency from 2299774510 Hz to 2299774582 Hz D0303 02:19:28.421919 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415073045559130 monotonicBaseRef:72000476376 monotonicFrequency:2299775262 realtimeReady:1 realtimeBaseCycles:9415073046202336 realtimeBaseRef:1583201968421790125 realtimeFrequency:2299774582} I0303 02:19:28.421952 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:28.422167 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:28.422339 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:28.422555 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:28.422802 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:28.422967 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:29.421349 2043 parameters.go:238] Clock(Monotonic): error: -145 ns, adjusted frequency from 2299775262 Hz to 2299774363 Hz D0303 02:19:29.421522 2043 parameters.go:238] Clock(Realtime): error: 168 ns, adjusted frequency from 2299774582 Hz to 2299774973 Hz D0303 02:19:29.421685 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415075344917792 monotonicBaseRef:73000295227 monotonicFrequency:2299774363 realtimeReady:1 realtimeBaseCycles:9415075345345856 realtimeBaseRef:1583201969421515723 realtimeFrequency:2299774973} D0303 02:19:30.421327 2043 parameters.go:238] Clock(Monotonic): error: -204 ns, adjusted frequency from 2299774363 Hz to 2299774172 Hz D0303 02:19:30.421534 2043 parameters.go:238] Clock(Realtime): error: -157 ns, adjusted frequency from 2299774973 Hz to 2299774240 Hz D0303 02:19:30.421621 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415077644646713 monotonicBaseRef:74000275467 monotonicFrequency:2299774172 realtimeReady:1 realtimeBaseCycles:9415077645148377 realtimeBaseRef:1583201970421527701 realtimeFrequency:2299774240} I0303 02:19:30.850641 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:30.850910 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:30.851093 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:30.851206 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:30.851262 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:30.851451 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:30.851675 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:30.851809 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:30.861588 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:30.861900 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:30.861993 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:30.862077 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:30.862167 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:30.862300 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:30.862454 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:30.862609 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:31.421254 2043 parameters.go:238] Clock(Monotonic): error: 186 ns, adjusted frequency from 2299774172 Hz to 2299775123 Hz D0303 02:19:31.421717 2043 parameters.go:238] Clock(Realtime): error: -107 ns, adjusted frequency from 2299774240 Hz to 2299774407 Hz D0303 02:19:31.421909 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415079944242813 monotonicBaseRef:75000198036 monotonicFrequency:2299775123 realtimeReady:1 realtimeBaseCycles:9415079945314234 realtimeBaseRef:1583201971421697985 realtimeFrequency:2299774407} I0303 02:19:31.422283 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:31.422614 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:31.422766 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:31.422935 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:31.422994 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:31.423105 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:31.423285 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:31.423456 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:31.850551 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:31.850853 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:31.851016 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:31.851053 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:31.851300 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:31.851453 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:32.421367 2043 parameters.go:238] Clock(Monotonic): error: -115 ns, adjusted frequency from 2299775123 Hz to 2299774333 Hz I0303 02:19:32.421581 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:32.421658 2043 parameters.go:238] Clock(Realtime): error: 303 ns, adjusted frequency from 2299774407 Hz to 2299775283 Hz D0303 02:19:32.421815 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:32.421826 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415082244193609 monotonicBaseRef:76000274423 monotonicFrequency:2299774333 realtimeReady:1 realtimeBaseCycles:9415082244975185 realtimeBaseRef:1583201972421648651 realtimeFrequency:2299775283} D0303 02:19:32.421952 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:32.421987 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:32.422274 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:32.422443 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:33.421341 2043 parameters.go:238] Clock(Monotonic): error: 2 ns, adjusted frequency from 2299774333 Hz to 2299774619 Hz D0303 02:19:33.421655 2043 parameters.go:238] Clock(Realtime): error: 79 ns, adjusted frequency from 2299775283 Hz to 2299774797 Hz D0303 02:19:33.421813 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415084543992222 monotonicBaseRef:77000284980 monotonicFrequency:2299774619 realtimeReady:1 realtimeBaseCycles:9415084544747395 realtimeBaseRef:1583201973421647314 realtimeFrequency:2299774797} D0303 02:19:34.421313 2043 parameters.go:238] Clock(Monotonic): error: 204 ns, adjusted frequency from 2299774619 Hz to 2299774913 Hz D0303 02:19:34.421564 2043 parameters.go:238] Clock(Realtime): error: -343 ns, adjusted frequency from 2299774797 Hz to 2299773803 Hz D0303 02:19:34.421695 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415086843706347 monotonicBaseRef:78000258675 monotonicFrequency:2299774913 realtimeReady:1 realtimeBaseCycles:9415086844319276 realtimeBaseRef:1583201974421559081 realtimeFrequency:2299773803} D0303 02:19:35.421309 2043 parameters.go:238] Clock(Monotonic): error: -261 ns, adjusted frequency from 2299774913 Hz to 2299774008 Hz D0303 02:19:35.421557 2043 parameters.go:238] Clock(Realtime): error: -180 ns, adjusted frequency from 2299773803 Hz to 2299774298 Hz D0303 02:19:35.421676 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415089143449959 monotonicBaseRef:79000245064 monotonicFrequency:2299774008 realtimeReady:1 realtimeBaseCycles:9415089144075980 realtimeBaseRef:1583201975421551645 realtimeFrequency:2299774298} D0303 02:19:36.421423 2043 parameters.go:238] Clock(Monotonic): error: 72 ns, adjusted frequency from 2299774008 Hz to 2299774783 Hz D0303 02:19:36.421646 2043 parameters.go:238] Clock(Realtime): error: 190 ns, adjusted frequency from 2299774298 Hz to 2299775066 Hz D0303 02:19:36.421763 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415091443510339 monotonicBaseRef:80000369585 monotonicFrequency:2299774783 realtimeReady:1 realtimeBaseCycles:9415091444055165 realtimeBaseRef:1583201976421640735 realtimeFrequency:2299775066} D0303 02:19:37.421233 2043 parameters.go:238] Clock(Monotonic): error: -43 ns, adjusted frequency from 2299774783 Hz to 2299774616 Hz D0303 02:19:37.421501 2043 parameters.go:238] Clock(Realtime): error: 70 ns, adjusted frequency from 2299775066 Hz to 2299774724 Hz D0303 02:19:37.421621 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415093742847744 monotonicBaseRef:81000179402 monotonicFrequency:2299774616 realtimeReady:1 realtimeBaseCycles:9415093743494979 realtimeBaseRef:1583201977421494959 realtimeFrequency:2299774724} I0303 02:19:37.737858 7572 main.go:305] *************************** I0303 02:19:37.738021 7572 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -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-proxy-sandbox-race-1 /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller845734798] I0303 02:19:37.738512 7572 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0303 02:19:37.738595 7572 main.go:308] PID: 7572 I0303 02:19:37.738708 7572 main.go:309] UID: 0, GID: 0 I0303 02:19:37.738800 7572 main.go:310] Configuration: I0303 02:19:37.738890 7572 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0303 02:19:37.738988 7572 main.go:312] Platform: ptrace I0303 02:19:37.739080 7572 main.go:313] FileAccess: shared, overlay: false I0303 02:19:37.739179 7572 main.go:314] Network: sandbox, logging: false I0303 02:19:37.739250 7572 main.go:315] Strace: false, max size: 1024, syscalls: [] I0303 02:19:37.739356 7572 main.go:316] *************************** W0303 02:19:37.739445 7572 main.go:321] Block the TERM signal. This is only safe in tests! D0303 02:19:37.745275 7572 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.754139 7572 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-1": signal 0 D0303 02:19:37.754288 7572 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.754387 7572 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.761355 2043 urpc.go:577] urpc: unmarshal success. D0303 02:19:37.761608 2043 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-1 Signo:0 PID:0 Mode:Process} D0303 02:19:37.762254 2043 urpc.go:534] urpc: successfully marshalled 37 bytes. D0303 02:19:37.763404 7572 urpc.go:534] urpc: successfully marshalled 117 bytes. D0303 02:19:37.764008 7572 urpc.go:577] urpc: unmarshal success. D0303 02:19:37.766492 7572 exec.go:120] Exec arguments: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller845734798 I0303 02:19:37.766463 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.766680 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:37.766811 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.766716 7572 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0303 02:19:37.766988 7572 container.go:533] Execute in container "ci-gvisor-ptrace-proxy-sandbox-race-1", args: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller845734798 D0303 02:19:37.767161 7572 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-1" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.767299 7572 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.766953 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.767157 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:37.767294 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:37.768015 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.768256 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:37.768418 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.768787 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:37.768927 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:37.769354 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.769592 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:37.769444 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:37.769932 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 I0303 02:19:37.769916 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.770117 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:37.770158 2043 task_signals.go:452] [ 2] Notified of group signal 23 D0303 02:19:37.770253 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:37.769640 2043 urpc.go:577] urpc: unmarshal success. D0303 02:19:37.773275 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:37.773318 7572 urpc.go:534] urpc: successfully marshalled 635 bytes. I0303 02:19:37.777741 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.772146 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:37.777941 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:37.778039 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.778245 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:37.778379 2043 task_run.go:155] [ 3] Restarting syscall 202 after errno 512: not interrupted by handled signal D0303 02:19:37.778479 2043 controller.go:267] containerManager.ExecuteAsync: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller845734798 D0303 02:19:37.778566 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:37.778736 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.778752 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0303 02:19:37.779138 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:37.779181 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:37.779314 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.779441 2043 task_signals.go:179] [ 3] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:37.779594 2043 task_signals.go:220] [ 3] Signal 23: delivering to handler D0303 02:19:37.781522 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:37.781714 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0303 02:19:37.782475 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} I0303 02:19:37.783116 2043 kernel.go:797] EXEC: [/syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller845734798] D0303 02:19:37.784093 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0303 02:19:37.785418 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] 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: 24119712, BlockSize: 4096, Blocks: 47112, ATime: {Sec: 1582836029, NanoSec: 349298839}, MTime: {Sec: 1582836029, NanoSec: 349298839}, CTime: {Sec: 1583201898, NanoSec: 36868938}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19136567}]} D0303 02:19:37.785641 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0303 02:19:37.786171 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:37.786500 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0303 02:19:37.788165 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19136567}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 24119712, BlockSize: 4096, Blocks: 47112, ATime: {Sec: 1582836029, NanoSec: 349298839}, MTime: {Sec: 1582836029, NanoSec: 349298839}, CTime: {Sec: 1583201898, NanoSec: 36868938}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0303 02:19:37.788334 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalk{FID: 5, NewFID: 6, Names: []} D0303 02:19:37.789106 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rwalk{QIDs: []} D0303 02:19:37.789263 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tlopen{FID: 6, Flags: ReadOnly} D0303 02:19:37.791331 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19136567}, IoUnit: 0, File: &{{36}}} I0303 02:19:37.794277 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.797912 2043 syscalls.go:266] Allocating stack with size of 8388608 bytes D0303 02:19:37.799271 2043 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-1 0}:0xc000424820 {ci-gvisor-ptrace-proxy-sandbox-race-1 23}:0xc00043f000] D0303 02:19:37.799605 2043 urpc.go:534] urpc: successfully marshalled 37 bytes. D0303 02:19:37.799575 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:37.799781 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.800017 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.800168 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:37.800260 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:37.801632 7572 urpc.go:577] urpc: unmarshal success. D0303 02:19:37.801801 7572 container.go:580] Wait on PID 23 in container "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.801996 7572 sandbox.go:761] Waiting for PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.802108 7572 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:37.802955 7572 urpc.go:534] urpc: successfully marshalled 100 bytes. D0303 02:19:37.804336 2043 urpc.go:577] urpc: unmarshal success. D0303 02:19:37.804594 2043 controller.go:443] containerManager.Wait D0303 02:19:37.810934 2043 task_block.go:223] [ 23] Interrupt queued I0303 02:19:37.961383 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.961651 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:37.961780 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.961932 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.962128 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:37.962274 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:37.981429 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.981690 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:37.981829 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.981949 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:37.982081 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:37.982222 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:37.982264 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:37.982349 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:37.982377 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.982753 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:37.982872 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:37.983085 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:37.983241 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:37.983395 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler I0303 02:19:38.011846 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.012098 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.012246 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.012319 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.012403 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.012581 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.012574 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.012688 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.012751 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.013250 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.013296 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.013377 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.013690 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:38.013878 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler I0303 02:19:38.084409 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.084636 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.084829 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.084937 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.085162 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.085337 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.125906 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.126126 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.126282 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.126446 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.126660 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.126766 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.141316 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.141601 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.141742 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.141853 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.142102 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.142267 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.145819 2043 task_block.go:223] [ 24] Interrupt queued D0303 02:19:38.152179 2043 task_block.go:223] [ 25] Interrupt queued D0303 02:19:38.153522 2043 task_block.go:223] [ 26] Interrupt queued D0303 02:19:38.166358 2043 urpc.go:577] urpc: unmarshal success. D0303 02:19:38.166636 2043 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-1 Signo:0 PID:0 Mode:Process} D0303 02:19:38.166939 2043 urpc.go:534] urpc: successfully marshalled 37 bytes. D0303 02:19:38.169110 2043 task_block.go:223] [ 27] Interrupt queued I0303 02:19:38.191448 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.191699 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.191818 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.191975 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.192259 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.192388 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.225775 2043 task_block.go:223] [ 28] Interrupt queued D0303 02:19:38.234387 2043 task_block.go:223] [ 29] Interrupt queued D0303 02:19:38.253459 2043 task_block.go:223] [ 30] Interrupt queued D0303 02:19:38.286220 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0303 02:19:38.287508 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.287760 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0303 02:19:38.288439 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} I0303 02:19:38.316034 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.316274 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.316462 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.316602 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.316779 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.316914 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.337721 2043 task_block.go:223] [ 31] Interrupt queued I0303 02:19:38.339679 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.340511 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.340708 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.340903 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.341020 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:38.341127 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.341243 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.341503 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.341424 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.341639 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.341713 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.341853 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.342068 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0303 02:19:38.342249 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.342446 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.342589 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.342596 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.344654 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0303 02:19:38.344852 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.344976 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:38.345091 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:38.345211 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:38.348674 2043 task_block.go:223] [ 32] Interrupt queued D0303 02:19:38.359815 2043 task_block.go:223] [ 33] Interrupt queued D0303 02:19:38.370208 2043 task_block.go:223] [ 34] Interrupt queued D0303 02:19:38.387676 2043 task_block.go:223] [ 35] Interrupt queued D0303 02:19:38.394840 2043 task_block.go:223] [ 36] Interrupt queued D0303 02:19:38.421337 2043 parameters.go:238] Clock(Monotonic): error: 64 ns, adjusted frequency from 2299774616 Hz to 2299774750 Hz D0303 02:19:38.421603 2043 parameters.go:238] Clock(Realtime): error: 163 ns, adjusted frequency from 2299774724 Hz to 2299775031 Hz D0303 02:19:38.422454 2043 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9415096042867474 monotonicBaseRef:82000285983 monotonicFrequency:2299774750 realtimeReady:1 realtimeBaseCycles:9415096043499512 realtimeBaseRef:1583201978421594885 realtimeFrequency:2299775031} D0303 02:19:38.430950 2043 task_block.go:223] [ 37] Interrupt queued I0303 02:19:38.432931 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.433181 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.433309 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.433427 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.433481 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.433693 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.433750 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.433887 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.434021 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.434455 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.434575 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.434840 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.435140 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:38.435309 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:38.442230 2043 task_block.go:223] [ 38] Interrupt queued D0303 02:19:38.483764 2043 task_block.go:223] [ 39] Interrupt queued D0303 02:19:38.490697 2043 task_block.go:223] [ 40] Interrupt queued D0303 02:19:38.491783 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller845734798]} D0303 02:19:38.493239 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rwalkgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 204, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583201977, NanoSec: 632669036}, MTime: {Sec: 1583201977, NanoSec: 632669036}, CTime: {Sec: 1583201977, NanoSec: 632669036}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19136520}]} D0303 02:19:38.493547 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller845734798, Size: 1} D0303 02:19:38.494116 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.494477 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0303 02:19:38.495615 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19136520}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 204, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583201977, NanoSec: 632669036}, MTime: {Sec: 1583201977, NanoSec: 632669036}, CTime: {Sec: 1583201977, NanoSec: 632669036}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0303 02:19:38.495847 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalk{FID: 7, NewFID: 8, Names: []} D0303 02:19:38.496567 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rwalk{QIDs: []} D0303 02:19:38.496763 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tlopen{FID: 8, Flags: ReadOnly} D0303 02:19:38.497849 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19136520}, IoUnit: 0, File: &{{30}}} D0303 02:19:38.499197 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0303 02:19:38.500588 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19136520}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 204, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583201977, NanoSec: 632669036}, MTime: {Sec: 1583201977, NanoSec: 632669036}, CTime: {Sec: 1583201977, NanoSec: 632669036}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} I0303 02:19:38.508220 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.508473 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.508605 2043 task_block.go:223] [ 1] Interrupt queued 2020/03/03 02:19:38 parsed 1 programs D0303 02:19:38.508959 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.509171 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.509296 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.518473 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.518718 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.518886 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.519020 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.519304 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.519438 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.522715 2043 task_stop.go:118] [ 33] Entering internal stop (*kernel.vforkStop)(nil) D0303 02:19:38.523505 2043 task_block.go:223] [ 41] Interrupt queued D0303 02:19:38.541057 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0303 02:19:38.542574 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] 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: 1579448, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1582836029, NanoSec: 449308645}, MTime: {Sec: 1582836029, NanoSec: 449308645}, CTime: {Sec: 1583201898, NanoSec: 44869722}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19136568}]} D0303 02:19:38.542923 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0303 02:19:38.543492 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.543786 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} I0303 02:19:38.544610 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.544772 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19136568}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579448, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1582836029, NanoSec: 449308645}, MTime: {Sec: 1582836029, NanoSec: 449308645}, CTime: {Sec: 1583201898, NanoSec: 44869722}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0303 02:19:38.544833 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.544973 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.545028 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalk{FID: 9, NewFID: 10, Names: []} D0303 02:19:38.545138 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.545309 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.545443 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.546788 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rwalk{QIDs: []} D0303 02:19:38.546940 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tlopen{FID: 10, Flags: ReadOnly} D0303 02:19:38.547658 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19136568}, IoUnit: 0, File: &{{31}}} D0303 02:19:38.548610 2043 syscalls.go:266] [ 41] Allocating stack with size of 8388608 bytes D0303 02:19:38.549580 2043 task_stop.go:137] [ 33] Leaving internal stop (*kernel.vforkStop)(nil) I0303 02:19:38.577668 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.577927 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.578061 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.578222 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.578385 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.578526 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.589031 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.589345 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.589486 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.589650 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.590623 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.591189 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.591026 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.591332 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.591517 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.591660 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.591789 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:38.592188 2043 task_block.go:223] [ 2] Interrupt queued I0303 02:19:38.592310 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.592294 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.592527 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.592790 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0303 02:19:38.593206 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.593206 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.596958 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.597134 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.597342 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.597475 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:38.597539 2043 task_signals.go:452] [ 2] Notified of group signal 23 D0303 02:19:38.597702 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:38.597734 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.598258 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:38.598378 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.598810 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:38.598816 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.599051 2043 task_signals.go:179] [ 3] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.599229 2043 task_signals.go:220] [ 3] Signal 23: delivering to handler D0303 02:19:38.600145 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.616606 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0303 02:19:38.618210 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.618381 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0303 02:19:38.619063 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.627967 2043 task_exit.go:221] [ 41] Transitioning from exit state TaskExitNone to TaskExitInitiated D0303 02:19:38.630392 2043 task_exit.go:221] [ 41] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0303 02:19:38.630600 2043 task_signals.go:446] [ 23] Notified of signal 17 D0303 02:19:38.630755 2043 task_block.go:223] [ 23] Interrupt queued D0303 02:19:38.630929 2043 task_block.go:223] [ 23] Interrupt queued D0303 02:19:38.631098 2043 task_signals.go:179] [ 23] Restarting syscall 202 after errno 512: interrupted by signal 17 D0303 02:19:38.631192 2043 task_signals.go:220] [ 23] Signal 17: delivering to handler D0303 02:19:38.631482 2043 task_exit.go:221] [ 41] Transitioning from exit state TaskExitZombie to TaskExitDead D0303 02:19:38.639873 2043 task_block.go:223] [ 42] Interrupt queued D0303 02:19:38.642191 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0303 02:19:38.643960 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] 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: 1579448, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1582836029, NanoSec: 449308645}, MTime: {Sec: 1582836029, NanoSec: 449308645}, CTime: {Sec: 1583201898, NanoSec: 44869722}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19136568}]} D0303 02:19:38.644293 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tclunk{FID: 11} D0303 02:19:38.644943 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rclunk{} D0303 02:19:38.645308 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0303 02:19:38.646465 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19136568}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579448, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1582836029, NanoSec: 449308645}, MTime: {Sec: 1582836029, NanoSec: 449308645}, CTime: {Sec: 1583201898, NanoSec: 44869722}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/03 02:19:38 executed programs: 0 I0303 02:19:38.654875 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.655018 2043 task_stop.go:118] [ 35] Entering internal stop (*kernel.vforkStop)(nil) D0303 02:19:38.655135 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.655305 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.655358 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.655558 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.655720 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.656094 2043 task_block.go:223] [ 43] Interrupt queued D0303 02:19:38.663392 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0303 02:19:38.664766 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] 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: 1579448, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1582836029, NanoSec: 449308645}, MTime: {Sec: 1582836029, NanoSec: 449308645}, CTime: {Sec: 1583201898, NanoSec: 44869722}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19136568}]} D0303 02:19:38.664895 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tclunk{FID: 11} D0303 02:19:38.665375 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rclunk{} D0303 02:19:38.665663 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0303 02:19:38.666681 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19136568}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579448, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1582836029, NanoSec: 449308645}, MTime: {Sec: 1582836029, NanoSec: 449308645}, CTime: {Sec: 1583201898, NanoSec: 44869722}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0303 02:19:38.667855 2043 syscalls.go:266] [ 43] Allocating stack with size of 8388608 bytes D0303 02:19:38.668846 2043 task_stop.go:137] [ 35] Leaving internal stop (*kernel.vforkStop)(nil) D0303 02:19:38.681369 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0303 02:19:38.682372 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.682594 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0303 02:19:38.683736 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} I0303 02:19:38.685300 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.685644 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.685855 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.685912 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.686180 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.686301 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.697401 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.697666 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.697817 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.698146 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.698353 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.698561 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.704164 2043 task_block.go:223] [ 44] Interrupt queued D0303 02:19:38.713679 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.714688 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.714911 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.715546 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.716029 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.716708 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.716890 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.717486 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.718108 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.755193 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.755450 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.757194 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.757852 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.758522 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.758741 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.759364 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.759794 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.761326 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.761528 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.762114 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.762840 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.763655 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.763860 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.764636 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.764937 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.765521 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.765660 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.766303 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.766645 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.767264 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.767502 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.768145 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:38.768740 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:38.769664 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:38.769857 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:38.770583 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} I0303 02:19:38.771577 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.771822 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.771995 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.772104 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.772381 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.772602 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.801830 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.802122 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.802269 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.802365 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.802625 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.802789 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.819507 2043 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0303 02:19:38.819823 2043 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0303 02:19:38.820120 2043 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0303 02:19:38.820268 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.820457 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.821249 2043 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0303 02:19:38.821382 2043 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 152 D0303 02:19:38.821467 2043 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 152 D0303 02:19:38.821570 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.821667 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.822308 2043 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0303 02:19:38.822419 2043 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0303 02:19:38.822531 2043 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 I0303 02:19:38.822466 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.822638 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.822746 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.822936 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.823149 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.822777 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.823379 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.823510 2043 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0303 02:19:38.823547 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.823612 2043 netfilter.go:54] netfilter: convert to binary: found hook 4 at offset 456 D0303 02:19:38.824031 2043 netfilter.go:54] netfilter: convert to binary: found underflow 4 at offset 456 D0303 02:19:38.824207 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.824341 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.825164 2043 netfilter.go:54] netfilter: convert to binary: current offset: 608 D0303 02:19:38.825755 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0303 02:19:38.826767 2043 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0303 02:19:38.826944 2043 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0303 02:19:38.827075 2043 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0303 02:19:38.827215 2043 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0303 02:19:38.827357 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.827491 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.828279 2043 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0303 02:19:38.828438 2043 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 152 D0303 02:19:38.828609 2043 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 152 D0303 02:19:38.828705 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.828855 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.829637 2043 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0303 02:19:38.829793 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0303 02:19:38.830872 2043 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0303 02:19:38.831041 2043 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0303 02:19:38.831142 2043 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 0 D0303 02:19:38.831219 2043 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 0 D0303 02:19:38.831299 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.831400 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.832070 2043 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0303 02:19:38.832228 2043 netfilter.go:54] netfilter: convert to binary: found hook 2 at offset 152 D0303 02:19:38.832380 2043 netfilter.go:54] netfilter: convert to binary: found underflow 2 at offset 152 D0303 02:19:38.832475 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0303 02:19:38.832626 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.833485 2043 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0303 02:19:38.833621 2043 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0303 02:19:38.833716 2043 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0303 02:19:38.834243 2043 netfilter.go:54] netfilter: convert to binary: marshalling standard target I0303 02:19:38.835081 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.835314 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.835526 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.835633 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.835709 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.835908 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:38.834915 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0303 02:19:38.836228 2043 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0303 02:19:38.836184 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.836427 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.836409 2043 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0303 02:19:38.837439 2043 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 I0303 02:19:38.838640 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.840805 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.840941 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.841075 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:38.841109 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.841311 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.841361 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.841464 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:38.841522 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.842002 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.842049 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:38.842164 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.842380 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:38.842529 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler I0303 02:19:38.863468 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.863647 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.863792 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.863900 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.864163 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.864290 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.878917 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.879141 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.879277 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.879387 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.879689 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.879896 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.894895 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.895166 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.895305 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.895374 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.895623 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.895799 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.915202 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.915434 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.915594 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.915655 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.915899 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.916013 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.941579 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.941827 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.941997 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.942115 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.942324 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.942451 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.961737 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.961971 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.962126 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.962274 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.962440 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.962531 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.985808 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.986004 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.986123 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.986165 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.986373 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.986492 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:38.996081 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:38.996264 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:38.996375 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.996547 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:38.996785 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:38.996920 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:39.011476 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.011693 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.011822 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.011892 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.012133 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.012265 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:39.031659 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.031864 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.031979 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.032087 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.032376 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.032639 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:39.052588 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.052884 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.053078 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.053201 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.053458 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.053663 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:39.072558 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} I0303 02:19:39.072778 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.072978 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.073079 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.073180 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.073411 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.073389 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.073542 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:39.073671 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.074211 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:39.074577 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.075186 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.075350 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.075988 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} I0303 02:19:39.077149 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.077690 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.077868 2043 task_block.go:223] [ 1] Interrupt queued I0303 02:19:39.078211 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.077989 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.078360 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0303 02:19:39.078523 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.078676 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.078644 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.078783 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.078907 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler I0303 02:19:39.079173 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.079204 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.081812 2043 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0303 02:19:39.082025 2043 task_block.go:223] [ 2] Interrupt queued I0303 02:19:39.082034 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.082193 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.082196 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:39.082337 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.082543 2043 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0303 02:19:39.082586 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.082695 2043 task_signals.go:220] [ 2] Signal 23: delivering to handler D0303 02:19:39.082569 2043 task_signals.go:452] [ 2] Notified of group signal 23 D0303 02:19:39.082894 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:39.083092 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:39.083193 2043 task_block.go:223] [ 2] Interrupt queued D0303 02:19:39.083248 2043 task_block.go:223] [ 3] Interrupt queued D0303 02:19:39.083693 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:39.083808 2043 task_signals.go:179] [ 3] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.083994 2043 task_signals.go:220] [ 3] Signal 23: delivering to handler D0303 02:19:39.084164 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.084660 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.084888 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.085412 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:39.085876 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.086712 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.086884 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.087452 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:39.087925 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.088527 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.088686 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.089281 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:39.089798 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.090369 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.090546 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.091077 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:39.091542 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.092299 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.092429 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.092950 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} I0303 02:19:39.093141 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.093353 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.093453 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.093579 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.093564 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.093808 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.093972 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:39.094453 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.094633 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.095204 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} D0303 02:19:39.095610 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0303 02:19:39.096142 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 2} D0303 02:19:39.096339 2043 transport_flipcall.go:127] send [channel @0xc0004683c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0303 02:19:39.096900 2043 transport_flipcall.go:234] recv [channel @0xc0004683c0] Rlerror{Error: 95} I0303 02:19:39.103615 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.103808 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.103932 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.104046 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.104391 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.104522 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:39.117625 2043 task_block.go:223] [ 45] Interrupt queued I0303 02:19:39.128977 2043 loader.go:566] Received external signal 23, mode: Process D0303 02:19:39.129204 2043 task_signals.go:446] [ 1] Notified of signal 23 D0303 02:19:39.129340 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.129414 2043 task_block.go:223] [ 1] Interrupt queued D0303 02:19:39.129650 2043 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0303 02:19:39.129759 2043 task_signals.go:220] [ 1] Signal 23: delivering to handler D0303 02:19:39.130195 2043 task_block.go:223] [ 46] Interrupt queued D0303 02:19:39.193409 2043 task_block.go:223] [ 47] Interrupt queued ================== WARNING: DATA RACE Write at 0x00c0001f4750 by goroutine 370: gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).SetSockOpt() pkg/tcpip/transport/tcp/endpoint.go:1510 +0xda7 gvisor.dev/gvisor/pkg/sentry/socket/netstack.setSockOptIP() pkg/sentry/socket/netstack/netstack.go:1999 +0x3c4 gvisor.dev/gvisor/pkg/sentry/socket/netstack.SetSockOpt() pkg/sentry/socket/netstack/netstack.go:1544 +0x232 DIAGNOSIS: I0303 02:19:39.246835 7703 main.go:305] *************************** I0303 02:19:39.247051 7703 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-1] I0303 02:19:39.247284 7703 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0303 02:19:39.247434 7703 main.go:308] PID: 7703 I0303 02:19:39.247539 7703 main.go:309] UID: 0, GID: 0 I0303 02:19:39.247641 7703 main.go:310] Configuration: I0303 02:19:39.247739 7703 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0303 02:19:39.247893 7703 main.go:312] Platform: ptrace I0303 02:19:39.248149 7703 main.go:313] FileAccess: shared, overlay: false I0303 02:19:39.248338 7703 main.go:314] Network: sandbox, logging: false I0303 02:19:39.248500 7703 main.go:315] Strace: false, max size: 1024, syscalls: [] I0303 02:19:39.248646 7703 main.go:316] *************************** W0303 02:19:39.248753 7703 main.go:321] Block the TERM signal. This is only safe in tests! D0303 02:19:39.249007 7703 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.263431 7703 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-1": signal 0 D0303 02:19:39.263664 7703 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.263806 7703 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.264430 7703 urpc.go:534] urpc: successfully marshalled 117 bytes. I0303 02:19:39.356128 7703 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1", PID: 2043 I0303 02:19:39.356319 7703 debug.go:131] Retrieving sandbox stacks D0303 02:19:39.356499 7703 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.356684 7703 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" W0303 02:19:39.356943 7703 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 2043: connection refused retrieving stacks: connecting to control server at PID 2043: connection refused W0303 02:19:39.357387 7703 main.go:338] Failure to execute command, err: 1 Error collecting stacks: failed to run ["/syzkaller/managers/ptrace-proxy-sandbox-race/current/image" "-root" "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "-watchdog-action=panic" "-network=none" "-debug" "-alsologtostderr" "-platform=ptrace" "-file-access=shared" "-network=sandbox" "-TESTONLY-unsafe-nonroot" "debug" "-stacks" "--ps" "ci-gvisor-ptrace-proxy-sandbox-race-1"]: exit status 128 I0303 02:19:39.246835 7703 main.go:305] *************************** I0303 02:19:39.247051 7703 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-1] I0303 02:19:39.247284 7703 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0303 02:19:39.247434 7703 main.go:308] PID: 7703 I0303 02:19:39.247539 7703 main.go:309] UID: 0, GID: 0 I0303 02:19:39.247641 7703 main.go:310] Configuration: I0303 02:19:39.247739 7703 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0303 02:19:39.247893 7703 main.go:312] Platform: ptrace I0303 02:19:39.248149 7703 main.go:313] FileAccess: shared, overlay: false I0303 02:19:39.248338 7703 main.go:314] Network: sandbox, logging: false I0303 02:19:39.248500 7703 main.go:315] Strace: false, max size: 1024, syscalls: [] I0303 02:19:39.248646 7703 main.go:316] *************************** W0303 02:19:39.248753 7703 main.go:321] Block the TERM signal. This is only safe in tests! D0303 02:19:39.249007 7703 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.263431 7703 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-1": signal 0 D0303 02:19:39.263664 7703 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.263806 7703 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.264430 7703 urpc.go:534] urpc: successfully marshalled 117 bytes. I0303 02:19:39.356128 7703 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1", PID: 2043 I0303 02:19:39.356319 7703 debug.go:131] Retrieving sandbox stacks D0303 02:19:39.356499 7703 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.356684 7703 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" W0303 02:19:39.356943 7703 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 2043: connection refused retrieving stacks: connecting to control server at PID 2043: connection refused W0303 02:19:39.357387 7703 main.go:338] Failure to execute command, err: 1 gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).SetSockOpt() pkg/sentry/socket/netstack/netstack.go:1527 +0x6a0 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.SetSockOpt() pkg/sentry/syscalls/linux/sys_socket.go:541 +0x2fd gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall() pkg/sentry/kernel/task_syscall.go:170 +0x44d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke() pkg/sentry/kernel/task_syscall.go:291 +0xb4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter() pkg/sentry/kernel/task_syscall.go:252 +0x109 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall() pkg/sentry/kernel/task_syscall.go:227 +0x1b3 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute() pkg/sentry/kernel/task_run.go:232 +0x1aaa gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run() pkg/sentry/kernel/task_run.go:92 +0x320 Previous read at 0x00c0001f4750 by goroutine 353: gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*handshake).execute() pkg/tcpip/transport/tcp/connect.go:556 +0x8a8 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).protocolMainLoop() pkg/tcpip/transport/tcp/connect.go:1280 +0xfc6 Goroutine 370 (running) created at: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start() pkg/sentry/kernel/task_start.go:315 +0x19d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Clone() pkg/sentry/kernel/task_clone.go:361 +0x1297 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.clone() pkg/sentry/syscalls/linux/sys_thread.go:226 +0x171 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Clone() pkg/sentry/syscalls/linux/sys_clone_amd64.go:34 +0x80 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall() pkg/sentry/kernel/task_syscall.go:170 +0x44d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke() pkg/sentry/kernel/task_syscall.go:291 +0xb4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter() pkg/sentry/kernel/task_syscall.go:252 +0x109 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall() pkg/sentry/kernel/task_syscall.go:227 +0x1b3 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute() pkg/sentry/kernel/task_run.go:232 +0x1aaa gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run() pkg/sentry/kernel/task_run.go:92 +0x320 Goroutine 353 (running) created at: gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).connect() pkg/tcpip/transport/tcp/endpoint.go:2058 +0xf2d gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).Connect() pkg/tcpip/transport/tcp/endpoint.go:1887 +0x8c gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).Connect() pkg/sentry/socket/netstack/netstack.go:698 +0x4c5 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Connect() pkg/sentry/syscalls/linux/sys_socket.go:280 +0x251 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall() pkg/sentry/kernel/task_syscall.go:170 +0x44d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke() pkg/sentry/kernel/task_syscall.go:291 +0xb4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter() pkg/sentry/kernel/task_syscall.go:252 +0x109 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall() pkg/sentry/kernel/task_syscall.go:227 +0x1b3 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute() pkg/sentry/kernel/task_run.go:232 +0x1aaa gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run() pkg/sentry/kernel/task_run.go:92 +0x320 ================== W0303 02:19:39.348766 7572 error.go:48] FATAL ERROR: waiting on pid 23: waiting on PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 23: waiting on PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1": urpc method "containerManager.WaitPID" failed: EOF W0303 02:19:39.349255 7572 main.go:338] Failure to execute command, err: 1 W0303 02:19:39.356846 2034 sandbox.go:742] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-1" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D0303 02:19:39.357254 2034 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.357451 2034 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.357587 2034 sandbox.go:1058] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-1" by destroying sandbox D0303 02:19:39.357733 2034 sandbox.go:788] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D0303 02:19:39.357837 2034 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-1", PID: 2041 I0303 02:19:39.560373 2034 main.go:329] Exiting with status: 16896