D0302 01:25:29.085081 47680 parameters.go:238] Clock(Monotonic): error: 208 ns, adjusted frequency from 2299773077 Hz to 2299774683 Hz D0302 01:25:29.085503 47680 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0302 01:25:29.085637 47680 parameters.go:238] Clock(Realtime): error: 577 ns, adjusted frequency from 2299774017 Hz to 2299775559 Hz D0302 01:25:29.085829 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208922775349929 monotonicBaseRef:2000358141 monotonicFrequency:2299774683 realtimeReady:1 realtimeBaseCycles:9208922776742744 realtimeBaseRef:1583112329085629608 realtimeFrequency:2299775559} I0302 01:25:29.332836 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:29.333109 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:29.333235 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:29.333489 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:29.333664 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:29.333867 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:25:29.345104 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:29.345361 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:29.345570 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:29.345786 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:29.346031 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:29.346206 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:30.085008 47680 parameters.go:238] Clock(Monotonic): error: 362 ns, adjusted frequency from 2299774683 Hz to 2299775230 Hz D0302 01:25:30.085249 47680 parameters.go:238] Clock(Realtime): error: 288 ns, adjusted frequency from 2299775559 Hz to 2299774958 Hz D0302 01:25:30.085404 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208925074947715 monotonicBaseRef:3000281221 monotonicFrequency:2299775230 realtimeReady:1 realtimeBaseCycles:9208925075628448 realtimeBaseRef:1583112330085242676 realtimeFrequency:2299774958} I0302 01:25:30.333191 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:30.333441 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:30.333575 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:30.333744 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:30.333909 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:30.334052 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:31.085054 47680 parameters.go:238] Clock(Monotonic): error: 59 ns, adjusted frequency from 2299775230 Hz to 2299774566 Hz D0302 01:25:31.085305 47680 parameters.go:238] Clock(Realtime): error: 283 ns, adjusted frequency from 2299774958 Hz to 2299775063 Hz D0302 01:25:31.085436 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208927374811676 monotonicBaseRef:4000319803 monotonicFrequency:2299774566 realtimeReady:1 realtimeBaseCycles:9208927375525153 realtimeBaseRef:1583112331085295614 realtimeFrequency:2299775063} I0302 01:25:31.333067 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:31.333381 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:31.333486 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:31.333635 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:25:31.333650 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:31.333823 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:31.333840 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:31.333979 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:31.334015 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:31.334577 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:31.334722 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:31.334743 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:31.335286 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:25:31.335443 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:25:32.084971 47680 parameters.go:238] Clock(Monotonic): error: 177 ns, adjusted frequency from 2299774566 Hz to 2299774887 Hz D0302 01:25:32.085252 47680 parameters.go:238] Clock(Realtime): error: 227 ns, adjusted frequency from 2299775063 Hz to 2299775181 Hz D0302 01:25:32.085417 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208929674511935 monotonicBaseRef:5000287492 monotonicFrequency:2299774887 realtimeReady:1 realtimeBaseCycles:9208929675181183 realtimeBaseRef:1583112332085243855 realtimeFrequency:2299775181} D0302 01:25:33.084970 47680 parameters.go:238] Clock(Monotonic): error: -66 ns, adjusted frequency from 2299774887 Hz to 2299774351 Hz D0302 01:25:33.085212 47680 parameters.go:238] Clock(Realtime): error: -453 ns, adjusted frequency from 2299775181 Hz to 2299773401 Hz D0302 01:25:33.085388 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208931974285708 monotonicBaseRef:6000287007 monotonicFrequency:2299774351 realtimeReady:1 realtimeBaseCycles:9208931974862092 realtimeBaseRef:1583112333085202863 realtimeFrequency:2299773401} D0302 01:25:34.085011 47680 parameters.go:238] Clock(Monotonic): error: -19 ns, adjusted frequency from 2299774351 Hz to 2299774476 Hz D0302 01:25:34.085257 47680 parameters.go:238] Clock(Realtime): error: 190 ns, adjusted frequency from 2299773401 Hz to 2299774927 Hz D0302 01:25:34.085433 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208934274146287 monotonicBaseRef:7000324501 monotonicFrequency:2299774476 realtimeReady:1 realtimeBaseCycles:9208934274747669 realtimeBaseRef:1583112334085251639 realtimeFrequency:2299774927} D0302 01:25:35.085039 47680 parameters.go:238] Clock(Monotonic): error: 96 ns, adjusted frequency from 2299774476 Hz to 2299774757 Hz D0302 01:25:35.085296 47680 parameters.go:238] Clock(Realtime): error: -22 ns, adjusted frequency from 2299774927 Hz to 2299774453 Hz D0302 01:25:35.085423 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208936573925295 monotonicBaseRef:8000326471 monotonicFrequency:2299774757 realtimeReady:1 realtimeBaseCycles:9208936574612470 realtimeBaseRef:1583112335085290718 realtimeFrequency:2299774453} I0302 01:25:35.333098 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:35.333339 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:35.333477 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:35.333640 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:35.333752 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:35.333866 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:36.085010 47680 parameters.go:238] Clock(Monotonic): error: 229 ns, adjusted frequency from 2299774757 Hz to 2299775068 Hz D0302 01:25:36.085367 47680 parameters.go:238] Clock(Realtime): error: -49 ns, adjusted frequency from 2299774453 Hz to 2299774468 Hz D0302 01:25:36.085583 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208938873693013 monotonicBaseRef:9000323410 monotonicFrequency:2299775068 realtimeReady:1 realtimeBaseCycles:9208938874523031 realtimeBaseRef:1583112336085349901 realtimeFrequency:2299774468} D0302 01:25:37.084994 47680 parameters.go:238] Clock(Monotonic): error: 213 ns, adjusted frequency from 2299775068 Hz to 2299775106 Hz I0302 01:25:37.085184 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:37.085256 47680 parameters.go:238] Clock(Realtime): error: -33 ns, adjusted frequency from 2299774468 Hz to 2299774534 Hz D0302 01:25:37.085482 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:37.085587 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208941173438315 monotonicBaseRef:10000310466 monotonicFrequency:2299775106 realtimeReady:1 realtimeBaseCycles:9208941174066257 realtimeBaseRef:1583112337085249351 realtimeFrequency:2299774534} D0302 01:25:37.085710 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:37.085800 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:37.086117 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:37.086259 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:25:37.087716 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:37.088129 47680 task_signals.go:452] [ 2] Notified of group signal 23 D0302 01:25:37.088280 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:37.088334 47680 task_block.go:223] [ 2] Interrupt queued I0302 01:25:37.088487 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:37.088988 47680 task_signals.go:452] [ 2] Notified of group signal 23 D0302 01:25:37.089159 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:37.089412 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:37.089321 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 I0302 01:25:37.090601 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:37.090692 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:37.090741 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:25:37.090817 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:37.090972 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:25:37.091128 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:37.091261 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:25:37.091280 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:25:37.091451 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:37.091753 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:25:37.092064 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:25:37.092196 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:37.092359 47680 task_signals.go:179] [ 3] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:37.092541 47680 task_signals.go:220] [ 3] Signal 23: delivering to handler D0302 01:25:38.085044 47680 parameters.go:238] Clock(Monotonic): error: -401 ns, adjusted frequency from 2299775106 Hz to 2299773723 Hz D0302 01:25:38.085287 47680 parameters.go:238] Clock(Realtime): error: 194 ns, adjusted frequency from 2299774534 Hz to 2299775062 Hz D0302 01:25:38.085467 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208943473256920 monotonicBaseRef:11000329380 monotonicFrequency:2299773723 realtimeReady:1 realtimeBaseCycles:9208943473916730 realtimeBaseRef:1583112338085282371 realtimeFrequency:2299775062} I0302 01:25:38.333115 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:38.333349 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:38.333444 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:38.333529 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:25:38.333571 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:38.333704 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:38.333800 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:38.333696 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:38.333892 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:38.334327 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:38.334428 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:38.334444 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:38.334733 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:25:38.334894 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 01:25:38.379704 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:38.379994 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:38.380141 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:38.380200 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:38.380454 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:38.380598 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:39.085016 47680 parameters.go:238] Clock(Monotonic): error: -89 ns, adjusted frequency from 2299773723 Hz to 2299774418 Hz D0302 01:25:39.085215 47680 parameters.go:238] Clock(Realtime): error: 107 ns, adjusted frequency from 2299775062 Hz to 2299774893 Hz D0302 01:25:39.085393 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208945773042436 monotonicBaseRef:12000334507 monotonicFrequency:2299774418 realtimeReady:1 realtimeBaseCycles:9208945773520884 realtimeBaseRef:1583112339085208055 realtimeFrequency:2299774893} D0302 01:25:40.085119 47680 parameters.go:238] Clock(Monotonic): error: 421 ns, adjusted frequency from 2299774418 Hz to 2299775484 Hz D0302 01:25:40.085336 47680 parameters.go:238] Clock(Realtime): error: -79 ns, adjusted frequency from 2299774893 Hz to 2299774438 Hz D0302 01:25:40.085529 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208948073055074 monotonicBaseRef:13000438091 monotonicFrequency:2299775484 realtimeReady:1 realtimeBaseCycles:9208948073577950 realtimeBaseRef:1583112340085330750 realtimeFrequency:2299774438} D0302 01:25:41.085042 47680 parameters.go:238] Clock(Monotonic): error: -169 ns, adjusted frequency from 2299775484 Hz to 2299774245 Hz I0302 01:25:41.085142 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:41.085306 47680 parameters.go:238] Clock(Realtime): error: 142 ns, adjusted frequency from 2299774438 Hz to 2299774785 Hz D0302 01:25:41.085392 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:41.085443 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208950372629953 monotonicBaseRef:14000350862 monotonicFrequency:2299774245 realtimeReady:1 realtimeBaseCycles:9208950373277441 realtimeBaseRef:1583112341085298161 realtimeFrequency:2299774785} D0302 01:25:41.085593 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:41.085723 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:41.086045 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:41.086169 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:42.084998 47680 parameters.go:238] Clock(Monotonic): error: 383 ns, adjusted frequency from 2299774245 Hz to 2299775442 Hz D0302 01:25:42.085182 47680 parameters.go:238] Clock(Realtime): error: -170 ns, adjusted frequency from 2299774785 Hz to 2299774292 Hz D0302 01:25:42.085336 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208952672320374 monotonicBaseRef:15000314413 monotonicFrequency:2299775442 realtimeReady:1 realtimeBaseCycles:9208952672772848 realtimeBaseRef:1583112342085176680 realtimeFrequency:2299774292} D0302 01:25:43.085646 47680 parameters.go:238] Clock(Monotonic): error: -59 ns, adjusted frequency from 2299775442 Hz to 2299774389 Hz D0302 01:25:43.085869 47680 parameters.go:238] Clock(Realtime): error: 158 ns, adjusted frequency from 2299774292 Hz to 2299775018 Hz D0302 01:25:43.086012 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208954973551993 monotonicBaseRef:16000947595 monotonicFrequency:2299774389 realtimeReady:1 realtimeBaseCycles:9208954974077898 realtimeBaseRef:1583112343085842292 realtimeFrequency:2299775018} I0302 01:25:43.086015 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:43.086264 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:43.086409 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:43.086456 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:25:43.086573 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:43.086688 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:25:43.086922 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:43.087101 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:25:43.333351 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:43.333568 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:43.333722 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:43.333874 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:43.334070 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:43.334194 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:44.084991 47680 parameters.go:238] Clock(Monotonic): error: -161 ns, adjusted frequency from 2299774389 Hz to 2299774281 Hz D0302 01:25:44.085248 47680 parameters.go:238] Clock(Realtime): error: -213 ns, adjusted frequency from 2299775018 Hz to 2299774210 Hz D0302 01:25:44.085415 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208957271838343 monotonicBaseRef:17000300558 monotonicFrequency:2299774281 realtimeReady:1 realtimeBaseCycles:9208957272467911 realtimeBaseRef:1583112344085240057 realtimeFrequency:2299774210} D0302 01:25:45.084896 47680 parameters.go:238] Clock(Monotonic): error: 208 ns, adjusted frequency from 2299774281 Hz to 2299775043 Hz D0302 01:25:45.085117 47680 parameters.go:238] Clock(Realtime): error: 152 ns, adjusted frequency from 2299774210 Hz to 2299774924 Hz D0302 01:25:45.085211 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208959571403065 monotonicBaseRef:18000209436 monotonicFrequency:2299775043 realtimeReady:1 realtimeBaseCycles:9208959571946182 realtimeBaseRef:1583112345085111375 realtimeFrequency:2299774924} I0302 01:25:45.945696 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:45.945974 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:45.946238 47680 urpc.go:577] urpc: unmarshal success. D0302 01:25:45.946158 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:45.946438 47680 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} I0302 01:25:45.946621 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:45.946735 47680 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 01:25:45.946844 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:25:45.946349 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:45.947121 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:45.947264 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:46.085118 47680 parameters.go:238] Clock(Monotonic): error: 54 ns, adjusted frequency from 2299775043 Hz to 2299774784 Hz D0302 01:25:46.085408 47680 parameters.go:238] Clock(Realtime): error: -225 ns, adjusted frequency from 2299774924 Hz to 2299774171 Hz D0302 01:25:46.085540 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208961871697537 monotonicBaseRef:19000435296 monotonicFrequency:2299774784 realtimeReady:1 realtimeBaseCycles:9208961872384816 realtimeBaseRef:1583112346085399972 realtimeFrequency:2299774171} I0302 01:25:46.333740 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:46.334044 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:46.334189 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:25:46.334349 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:46.334376 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:46.334488 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:25:46.334655 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:46.334815 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:47.084871 47680 parameters.go:238] Clock(Monotonic): error: -261 ns, adjusted frequency from 2299774784 Hz to 2299774054 Hz D0302 01:25:47.085225 47680 parameters.go:238] Clock(Realtime): error: 473 ns, adjusted frequency from 2299774171 Hz to 2299775738 Hz I0302 01:25:47.085306 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:47.085395 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208964170909908 monotonicBaseRef:20000190744 monotonicFrequency:2299774054 realtimeReady:1 realtimeBaseCycles:9208964171739729 realtimeBaseRef:1583112347085217668 realtimeFrequency:2299775738} D0302 01:25:47.085516 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:47.085647 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:47.085672 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:47.085909 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:47.086117 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:25:47.086547 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:47.086671 47680 task_signals.go:452] [ 2] Notified of group signal 23 D0302 01:25:47.086821 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:47.086936 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:47.086950 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:47.087094 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:47.087121 47680 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0302 01:25:47.332920 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:47.333165 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:47.333312 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:47.333351 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:25:47.333443 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:47.333596 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:47.333683 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:47.333560 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:47.333811 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:47.334481 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:47.334506 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:47.334619 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:47.334805 47680 task_signals.go:176] [ 2] Not restarting syscall 270 after errno 514: interrupted by signal 23 D0302 01:25:47.334943 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:25:48.084978 47680 parameters.go:238] Clock(Monotonic): error: -147 ns, adjusted frequency from 2299774054 Hz to 2299774316 Hz D0302 01:25:48.085180 47680 parameters.go:238] Clock(Realtime): error: -515 ns, adjusted frequency from 2299775738 Hz to 2299773507 Hz D0302 01:25:48.085318 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208966470928212 monotonicBaseRef:21000296950 monotonicFrequency:2299774316 realtimeReady:1 realtimeBaseCycles:9208966471413952 realtimeBaseRef:1583112348085173526 realtimeFrequency:2299773507} D0302 01:25:49.085294 47680 parameters.go:238] Clock(Monotonic): error: 322 ns, adjusted frequency from 2299774316 Hz to 2299775398 Hz D0302 01:25:49.085498 47680 parameters.go:238] Clock(Realtime): error: 8 ns, adjusted frequency from 2299773507 Hz to 2299774719 Hz D0302 01:25:49.085625 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208968771422337 monotonicBaseRef:22000609941 monotonicFrequency:2299775398 realtimeReady:1 realtimeBaseCycles:9208968771919404 realtimeBaseRef:1583112349085491794 realtimeFrequency:2299774719} D0302 01:25:50.084941 47680 parameters.go:238] Clock(Monotonic): error: -47 ns, adjusted frequency from 2299775398 Hz to 2299774433 Hz D0302 01:25:50.085172 47680 parameters.go:238] Clock(Realtime): error: 171 ns, adjusted frequency from 2299774719 Hz to 2299775121 Hz D0302 01:25:50.085283 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208971070390401 monotonicBaseRef:23000258891 monotonicFrequency:2299774433 realtimeReady:1 realtimeBaseCycles:9208971070944798 realtimeBaseRef:1583112350085165968 realtimeFrequency:2299775121} I0302 01:25:50.333388 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:50.334115 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:50.334235 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:50.334348 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:50.334598 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:50.334773 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:51.084957 47680 parameters.go:238] Clock(Monotonic): error: -111 ns, adjusted frequency from 2299774433 Hz to 2299774470 Hz D0302 01:25:51.085653 47680 parameters.go:238] Clock(Realtime): error: 167 ns, adjusted frequency from 2299775121 Hz to 2299774989 Hz D0302 01:25:51.085842 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208973370196918 monotonicBaseRef:24000272841 monotonicFrequency:2299774470 realtimeReady:1 realtimeBaseCycles:9208973371819554 realtimeBaseRef:1583112351085644116 realtimeFrequency:2299774989} I0302 01:25:51.333037 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:51.333308 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:51.333483 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:51.333537 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:51.333793 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:51.333979 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:52.086622 47680 parameters.go:238] Clock(Monotonic): error: -160 ns, adjusted frequency from 2299774470 Hz to 2299774389 Hz D0302 01:25:52.086902 47680 parameters.go:238] Clock(Realtime): error: -128 ns, adjusted frequency from 2299774989 Hz to 2299774316 Hz D0302 01:25:52.087030 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208975673801698 monotonicBaseRef:25001938356 monotonicFrequency:2299774389 realtimeReady:1 realtimeBaseCycles:9208975674471995 realtimeBaseRef:1583112352086895304 realtimeFrequency:2299774316} D0302 01:25:53.085012 47680 parameters.go:238] Clock(Monotonic): error: 229 ns, adjusted frequency from 2299774389 Hz to 2299775000 Hz D0302 01:25:53.085216 47680 parameters.go:238] Clock(Realtime): error: -62 ns, adjusted frequency from 2299774316 Hz to 2299774456 Hz D0302 01:25:53.085332 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208977969781206 monotonicBaseRef:26000288245 monotonicFrequency:2299775000 realtimeReady:1 realtimeBaseCycles:9208977970362932 realtimeBaseRef:1583112353085206712 realtimeFrequency:2299774456} D0302 01:25:54.084955 47680 parameters.go:238] Clock(Monotonic): error: -292 ns, adjusted frequency from 2299775000 Hz to 2299774048 Hz D0302 01:25:54.085185 47680 parameters.go:238] Clock(Realtime): error: 30 ns, adjusted frequency from 2299774456 Hz to 2299774775 Hz D0302 01:25:54.085320 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208980269487125 monotonicBaseRef:27000258206 monotonicFrequency:2299774048 realtimeReady:1 realtimeBaseCycles:9208980270070424 realtimeBaseRef:1583112354085177594 realtimeFrequency:2299774775} D0302 01:25:55.085004 47680 parameters.go:238] Clock(Monotonic): error: 220 ns, adjusted frequency from 2299774048 Hz to 2299775231 Hz D0302 01:25:55.085342 47680 parameters.go:238] Clock(Realtime): error: -158 ns, adjusted frequency from 2299774775 Hz to 2299774285 Hz D0302 01:25:55.085547 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208982569394660 monotonicBaseRef:28000316249 monotonicFrequency:2299775231 realtimeReady:1 realtimeBaseCycles:9208982570202413 realtimeBaseRef:1583112355085332919 realtimeFrequency:2299774285} D0302 01:25:56.084968 47680 parameters.go:238] Clock(Monotonic): error: 204 ns, adjusted frequency from 2299775231 Hz to 2299774974 Hz D0302 01:25:56.085171 47680 parameters.go:238] Clock(Realtime): error: -46 ns, adjusted frequency from 2299774285 Hz to 2299774565 Hz D0302 01:25:56.085278 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208984869089225 monotonicBaseRef:29000281173 monotonicFrequency:2299774974 realtimeReady:1 realtimeBaseCycles:9208984869590689 realtimeBaseRef:1583112356085165072 realtimeFrequency:2299774565} D0302 01:25:57.084944 47680 parameters.go:238] Clock(Monotonic): error: -435 ns, adjusted frequency from 2299774974 Hz to 2299773639 Hz D0302 01:25:57.085213 47680 parameters.go:238] Clock(Realtime): error: 122 ns, adjusted frequency from 2299774565 Hz to 2299774891 Hz I0302 01:25:57.085210 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:57.085367 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208987168819558 monotonicBaseRef:30000261761 monotonicFrequency:2299773639 realtimeReady:1 realtimeBaseCycles:9208987169462255 realtimeBaseRef:1583112357085207250 realtimeFrequency:2299774891} D0302 01:25:57.085455 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:57.085637 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:57.085735 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:25:57.085818 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:57.085980 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:25:57.086057 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:57.086164 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:57.086189 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:57.087490 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:57.087620 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:57.087690 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:57.088015 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:25:57.088185 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:25:58.084987 47680 parameters.go:238] Clock(Monotonic): error: 378 ns, adjusted frequency from 2299773639 Hz to 2299775652 Hz D0302 01:25:58.085252 47680 parameters.go:238] Clock(Realtime): error: 266 ns, adjusted frequency from 2299774891 Hz to 2299775184 Hz D0302 01:25:58.085424 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208989468686052 monotonicBaseRef:31000302136 monotonicFrequency:2299775652 realtimeReady:1 realtimeBaseCycles:9208989469325738 realtimeBaseRef:1583112358085245772 realtimeFrequency:2299775184} I0302 01:25:58.334315 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:58.334566 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:58.334704 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:58.334884 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:58.335082 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0302 01:25:58.335100 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:25:58.335260 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:25:58.335313 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:25:58.335460 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:58.335670 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:58.335698 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:25:58.335787 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:25:58.335941 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:25:58.336070 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:25:59.086095 47680 parameters.go:238] Clock(Monotonic): error: -135 ns, adjusted frequency from 2299775652 Hz to 2299774461 Hz D0302 01:25:59.086502 47680 parameters.go:238] Clock(Realtime): error: 93 ns, adjusted frequency from 2299775184 Hz to 2299774792 Hz D0302 01:25:59.086647 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208991771007508 monotonicBaseRef:32001409115 monotonicFrequency:2299774461 realtimeReady:1 realtimeBaseCycles:9208991771969111 realtimeBaseRef:1583112359086492932 realtimeFrequency:2299774792} D0302 01:26:00.085144 47680 parameters.go:238] Clock(Monotonic): error: 302 ns, adjusted frequency from 2299774461 Hz to 2299775266 Hz I0302 01:26:00.085285 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:00.085446 47680 parameters.go:238] Clock(Realtime): error: 35 ns, adjusted frequency from 2299774792 Hz to 2299774733 Hz D0302 01:26:00.085513 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:00.085748 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:00.085807 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:00.085922 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:00.085630 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208994068596848 monotonicBaseRef:33000458969 monotonicFrequency:2299775266 realtimeReady:1 realtimeBaseCycles:9208994069314902 realtimeBaseRef:1583112360085436741 realtimeFrequency:2299774733} D0302 01:26:00.086036 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:00.086214 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:00.086369 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:01.084956 47680 parameters.go:238] Clock(Monotonic): error: -542 ns, adjusted frequency from 2299775266 Hz to 2299773411 Hz D0302 01:26:01.085231 47680 parameters.go:238] Clock(Realtime): error: -220 ns, adjusted frequency from 2299774733 Hz to 2299774153 Hz D0302 01:26:01.085329 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208996367937772 monotonicBaseRef:34000270106 monotonicFrequency:2299773411 realtimeReady:1 realtimeBaseCycles:9208996368603246 realtimeBaseRef:1583112361085225246 realtimeFrequency:2299774153} I0302 01:26:01.085274 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:01.085594 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:01.085777 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:01.085866 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:01.085937 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:01.086094 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:01.086281 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:01.086447 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:02.084918 47680 parameters.go:238] Clock(Monotonic): error: 196 ns, adjusted frequency from 2299773411 Hz to 2299775264 Hz I0302 01:26:02.085063 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:02.085183 47680 parameters.go:238] Clock(Realtime): error: 276 ns, adjusted frequency from 2299774153 Hz to 2299775305 Hz D0302 01:26:02.085280 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:02.085437 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:02.085376 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9208998667629057 monotonicBaseRef:35000234395 monotonicFrequency:2299775264 realtimeReady:1 realtimeBaseCycles:9208998668265667 realtimeBaseRef:1583112362085176662 realtimeFrequency:2299775305} D0302 01:26:02.085555 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:02.085596 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:02.085752 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:02.085776 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:02.085934 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:02.085977 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:02.086467 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:02.086621 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:02.086622 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:02.086898 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:02.087062 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:03.085317 47680 parameters.go:238] Clock(Monotonic): error: -7 ns, adjusted frequency from 2299775264 Hz to 2299774664 Hz D0302 01:26:03.085626 47680 parameters.go:238] Clock(Realtime): error: -174 ns, adjusted frequency from 2299775305 Hz to 2299774196 Hz D0302 01:26:03.085773 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209000968290465 monotonicBaseRef:36000619712 monotonicFrequency:2299774664 realtimeReady:1 realtimeBaseCycles:9209000969055014 realtimeBaseRef:1583112363085617592 realtimeFrequency:2299774196} D0302 01:26:04.084971 47680 parameters.go:238] Clock(Monotonic): error: -210 ns, adjusted frequency from 2299774664 Hz to 2299774178 Hz D0302 01:26:04.085248 47680 parameters.go:238] Clock(Realtime): error: -86 ns, adjusted frequency from 2299774196 Hz to 2299774376 Hz D0302 01:26:04.085395 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209003267298209 monotonicBaseRef:37000286235 monotonicFrequency:2299774178 realtimeReady:1 realtimeBaseCycles:9209003267964256 realtimeBaseRef:1583112364085241488 realtimeFrequency:2299774376} D0302 01:26:05.085386 47680 parameters.go:238] Clock(Monotonic): error: 146 ns, adjusted frequency from 2299774178 Hz to 2299775122 Hz D0302 01:26:05.085676 47680 parameters.go:238] Clock(Realtime): error: 55 ns, adjusted frequency from 2299774376 Hz to 2299774816 Hz D0302 01:26:05.085815 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209005567991414 monotonicBaseRef:38000685851 monotonicFrequency:2299775122 realtimeReady:1 realtimeBaseCycles:9209005568717110 realtimeBaseRef:1583112365085666954 realtimeFrequency:2299774816} D0302 01:26:06.087395 47680 parameters.go:238] Clock(Monotonic): error: 62 ns, adjusted frequency from 2299775122 Hz to 2299774672 Hz D0302 01:26:06.087664 47680 parameters.go:238] Clock(Realtime): error: -90 ns, adjusted frequency from 2299774816 Hz to 2299774407 Hz D0302 01:26:06.087788 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209007872418572 monotonicBaseRef:39002708673 monotonicFrequency:2299774672 realtimeReady:1 realtimeBaseCycles:9209007873071209 realtimeBaseRef:1583112366087658141 realtimeFrequency:2299774407} I0302 01:26:06.333033 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:06.333314 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:06.333458 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:06.333754 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:06.333987 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:06.334146 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:06.345172 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:06.345460 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:06.345632 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:06.345669 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:06.345855 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:06.345934 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:06.346073 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:06.346049 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:06.346222 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:06.346494 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:06.346626 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:06.346983 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:06.347074 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:06.347507 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:06.347663 47680 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal D0302 01:26:07.085074 47680 parameters.go:238] Clock(Monotonic): error: -185 ns, adjusted frequency from 2299774672 Hz to 2299774195 Hz D0302 01:26:07.085397 47680 parameters.go:238] Clock(Realtime): error: 166 ns, adjusted frequency from 2299774407 Hz to 2299775039 Hz D0302 01:26:07.085587 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209010166840625 monotonicBaseRef:40000381219 monotonicFrequency:2299774195 realtimeReady:1 realtimeBaseCycles:9209010167625034 realtimeBaseRef:1583112367085388100 realtimeFrequency:2299775039} D0302 01:26:08.084963 47680 parameters.go:238] Clock(Monotonic): error: 122 ns, adjusted frequency from 2299774195 Hz to 2299774929 Hz D0302 01:26:08.085180 47680 parameters.go:238] Clock(Realtime): error: -76 ns, adjusted frequency from 2299775039 Hz to 2299774504 Hz D0302 01:26:08.085392 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209012466360057 monotonicBaseRef:41000270441 monotonicFrequency:2299774929 realtimeReady:1 realtimeBaseCycles:9209012466905265 realtimeBaseRef:1583112368085172945 realtimeFrequency:2299774504} I0302 01:26:08.379910 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:08.380227 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:08.380418 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:08.380395 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:08.380612 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:08.380742 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:09.085029 47680 parameters.go:238] Clock(Monotonic): error: 46 ns, adjusted frequency from 2299774929 Hz to 2299774724 Hz D0302 01:26:09.085356 47680 parameters.go:238] Clock(Realtime): error: 36 ns, adjusted frequency from 2299774504 Hz to 2299774730 Hz D0302 01:26:09.085498 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209014766287879 monotonicBaseRef:42000336922 monotonicFrequency:2299774724 realtimeReady:1 realtimeBaseCycles:9209014767085252 realtimeBaseRef:1583112369085349259 realtimeFrequency:2299774730} I0302 01:26:09.085920 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:09.086518 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:09.087190 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:09.087475 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:09.088077 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:09.088866 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:10.085927 47680 parameters.go:238] Clock(Monotonic): error: 135 ns, adjusted frequency from 2299774724 Hz to 2299774818 Hz D0302 01:26:10.086183 47680 parameters.go:238] Clock(Realtime): error: -136 ns, adjusted frequency from 2299774730 Hz to 2299774355 Hz D0302 01:26:10.086329 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209017068148636 monotonicBaseRef:43001243981 monotonicFrequency:2299774818 realtimeReady:1 realtimeBaseCycles:9209017068765150 realtimeBaseRef:1583112370086177674 realtimeFrequency:2299774355} D0302 01:26:11.084977 47680 parameters.go:238] Clock(Monotonic): error: -44 ns, adjusted frequency from 2299774818 Hz to 2299774471 Hz D0302 01:26:11.085240 47680 parameters.go:238] Clock(Realtime): error: 82 ns, adjusted frequency from 2299774355 Hz to 2299774800 Hz D0302 01:26:11.085359 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209019365732290 monotonicBaseRef:44000291207 monotonicFrequency:2299774471 realtimeReady:1 realtimeBaseCycles:9209019366367943 realtimeBaseRef:1583112371085233423 realtimeFrequency:2299774800} D0302 01:26:12.085459 47680 parameters.go:238] Clock(Monotonic): error: -119 ns, adjusted frequency from 2299774471 Hz to 2299774362 Hz I0302 01:26:12.085573 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:12.085744 47680 parameters.go:238] Clock(Realtime): error: 76 ns, adjusted frequency from 2299774800 Hz to 2299774790 Hz D0302 01:26:12.085891 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:12.085924 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209021666613766 monotonicBaseRef:45000772560 monotonicFrequency:2299774362 realtimeReady:1 realtimeBaseCycles:9209021667296962 realtimeBaseRef:1583112372085735306 realtimeFrequency:2299774790} D0302 01:26:12.086079 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:12.086241 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:12.086238 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:12.086418 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:12.086539 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:12.086674 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:12.275228 47680 watchdog.go:277] Watchdog starting loop, tasks: 15, discount: 0s D0302 01:26:13.085103 47680 parameters.go:238] Clock(Monotonic): error: 250 ns, adjusted frequency from 2299774362 Hz to 2299775080 Hz D0302 01:26:13.085343 47680 parameters.go:238] Clock(Realtime): error: -148 ns, adjusted frequency from 2299774790 Hz to 2299774329 Hz D0302 01:26:13.085454 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209023965516757 monotonicBaseRef:46000393665 monotonicFrequency:2299775080 realtimeReady:1 realtimeBaseCycles:9209023966141201 realtimeBaseRef:1583112373085330678 realtimeFrequency:2299774329} D0302 01:26:14.085025 47680 parameters.go:238] Clock(Monotonic): error: -21 ns, adjusted frequency from 2299775080 Hz to 2299774549 Hz D0302 01:26:14.085254 47680 parameters.go:238] Clock(Realtime): error: 60 ns, adjusted frequency from 2299774329 Hz to 2299774685 Hz D0302 01:26:14.085379 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209026265165469 monotonicBaseRef:47000338717 monotonicFrequency:2299774549 realtimeReady:1 realtimeBaseCycles:9209026265725377 realtimeBaseRef:1583112374085247994 realtimeFrequency:2299774685} D0302 01:26:15.084945 47680 parameters.go:238] Clock(Monotonic): error: 289 ns, adjusted frequency from 2299774549 Hz to 2299775501 Hz I0302 01:26:15.085102 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:15.085182 47680 parameters.go:238] Clock(Realtime): error: 410 ns, adjusted frequency from 2299774685 Hz to 2299775643 Hz D0302 01:26:15.085342 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:15.085465 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:15.085331 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209028564759656 monotonicBaseRef:48000260291 monotonicFrequency:2299775501 realtimeReady:1 realtimeBaseCycles:9209028565332380 realtimeBaseRef:1583112375085175081 realtimeFrequency:2299775643} D0302 01:26:15.085627 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:15.085666 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:15.085812 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:15.085978 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:15.086083 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:16.084937 47680 parameters.go:238] Clock(Monotonic): error: -597 ns, adjusted frequency from 2299775501 Hz to 2299773269 Hz D0302 01:26:16.087056 47680 parameters.go:238] Clock(Realtime): error: -376 ns, adjusted frequency from 2299775643 Hz to 2299773729 Hz I0302 01:26:16.087146 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:16.087382 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:16.087264 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209030864513069 monotonicBaseRef:49000250686 monotonicFrequency:2299773269 realtimeReady:1 realtimeBaseCycles:9209030866468301 realtimeBaseRef:1583112376085766563 realtimeFrequency:2299773729} D0302 01:26:16.087547 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:16.087570 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:16.087692 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:16.087803 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:16.087835 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:16.088076 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:16.087940 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:16.088358 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:16.088532 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:16.088819 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:16.088858 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:16.088984 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:16.089127 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:16.089337 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:17.084990 47680 parameters.go:238] Clock(Monotonic): error: 26 ns, adjusted frequency from 2299773269 Hz to 2299774673 Hz D0302 01:26:17.085265 47680 parameters.go:238] Clock(Realtime): error: -29 ns, adjusted frequency from 2299773729 Hz to 2299774605 Hz D0302 01:26:17.085363 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209033164401192 monotonicBaseRef:50000300627 monotonicFrequency:2299774673 realtimeReady:1 realtimeBaseCycles:9209033165072443 realtimeBaseRef:1583112377085257996 realtimeFrequency:2299774605} D0302 01:26:18.085436 47680 parameters.go:238] Clock(Monotonic): error: 65 ns, adjusted frequency from 2299774673 Hz to 2299774911 Hz D0302 01:26:18.085670 47680 parameters.go:238] Clock(Realtime): error: 82 ns, adjusted frequency from 2299774605 Hz to 2299774791 Hz D0302 01:26:18.085801 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209035465212069 monotonicBaseRef:51000751194 monotonicFrequency:2299774911 realtimeReady:1 realtimeBaseCycles:9209035465779497 realtimeBaseRef:1583112378085663448 realtimeFrequency:2299774791} D0302 01:26:19.085222 47680 parameters.go:238] Clock(Monotonic): error: 313 ns, adjusted frequency from 2299774911 Hz to 2299775421 Hz D0302 01:26:19.085430 47680 parameters.go:238] Clock(Realtime): error: -190 ns, adjusted frequency from 2299774791 Hz to 2299774182 Hz D0302 01:26:19.085521 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209037764495618 monotonicBaseRef:52000537537 monotonicFrequency:2299775421 realtimeReady:1 realtimeBaseCycles:9209037765005830 realtimeBaseRef:1583112379085424964 realtimeFrequency:2299774182} D0302 01:26:20.085285 47680 parameters.go:238] Clock(Monotonic): error: -476 ns, adjusted frequency from 2299775421 Hz to 2299773622 Hz D0302 01:26:20.085506 47680 parameters.go:238] Clock(Realtime): error: 48 ns, adjusted frequency from 2299774182 Hz to 2299774752 Hz D0302 01:26:20.085609 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209040064414991 monotonicBaseRef:53000600130 monotonicFrequency:2299773622 realtimeReady:1 realtimeBaseCycles:9209040064956413 realtimeBaseRef:1583112380085501667 realtimeFrequency:2299774752} D0302 01:26:21.084915 47680 parameters.go:238] Clock(Monotonic): error: -61 ns, adjusted frequency from 2299773622 Hz to 2299774496 Hz I0302 01:26:21.085082 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:21.085225 47680 parameters.go:238] Clock(Realtime): error: -208 ns, adjusted frequency from 2299774752 Hz to 2299774255 Hz D0302 01:26:21.085296 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:21.085343 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209042363339772 monotonicBaseRef:54000231032 monotonicFrequency:2299774496 realtimeReady:1 realtimeBaseCycles:9209042364079603 realtimeBaseRef:1583112381085218351 realtimeFrequency:2299774255} D0302 01:26:21.085453 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:21.085492 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:21.085712 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:21.085870 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:21.345124 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:21.345349 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:21.345453 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:21.345623 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:21.345778 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:21.345866 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:22.086032 47680 parameters.go:238] Clock(Monotonic): error: 233 ns, adjusted frequency from 2299774496 Hz to 2299775339 Hz D0302 01:26:22.086310 47680 parameters.go:238] Clock(Realtime): error: 548 ns, adjusted frequency from 2299774255 Hz to 2299775893 Hz D0302 01:26:22.086471 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209044665675883 monotonicBaseRef:55001344886 monotonicFrequency:2299775339 realtimeReady:1 realtimeBaseCycles:9209044666345950 realtimeBaseRef:1583112382086301975 realtimeFrequency:2299775893} D0302 01:26:22.580643 47680 urpc.go:577] urpc: unmarshal success. D0302 01:26:22.580901 47680 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0302 01:26:22.582501 47680 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 01:26:23.084887 47680 parameters.go:238] Clock(Monotonic): error: 257 ns, adjusted frequency from 2299775339 Hz to 2299775211 Hz D0302 01:26:23.085150 47680 parameters.go:238] Clock(Realtime): error: -225 ns, adjusted frequency from 2299775893 Hz to 2299774138 Hz D0302 01:26:23.085305 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209046962800220 monotonicBaseRef:56000192163 monotonicFrequency:2299775211 realtimeReady:1 realtimeBaseCycles:9209046963451429 realtimeBaseRef:1583112383085140812 realtimeFrequency:2299774138} D0302 01:26:24.085716 47680 parameters.go:238] Clock(Monotonic): error: -391 ns, adjusted frequency from 2299775211 Hz to 2299773693 Hz D0302 01:26:24.086013 47680 parameters.go:238] Clock(Realtime): error: 14 ns, adjusted frequency from 2299774138 Hz to 2299774624 Hz I0302 01:26:24.085818 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:24.086438 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:24.086153 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209049264510424 monotonicBaseRef:57001033546 monotonicFrequency:2299773693 realtimeReady:1 realtimeBaseCycles:9209049265215310 realtimeBaseRef:1583112384086006002 realtimeFrequency:2299774624} D0302 01:26:24.086694 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:24.086755 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:24.086872 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:24.087070 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:24.087350 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:24.087527 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:25.085723 47680 parameters.go:238] Clock(Monotonic): error: -6 ns, adjusted frequency from 2299773693 Hz to 2299774650 Hz D0302 01:26:25.085919 47680 parameters.go:238] Clock(Realtime): error: -9 ns, adjusted frequency from 2299774624 Hz to 2299774691 Hz D0302 01:26:25.086062 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209051564302380 monotonicBaseRef:58001041487 monotonicFrequency:2299774650 realtimeReady:1 realtimeBaseCycles:9209051564777394 realtimeBaseRef:1583112385085913584 realtimeFrequency:2299774691} D0302 01:26:26.084973 47680 parameters.go:238] Clock(Monotonic): error: -8 ns, adjusted frequency from 2299774650 Hz to 2299774652 Hz D0302 01:26:26.085216 47680 parameters.go:238] Clock(Realtime): error: -1 ns, adjusted frequency from 2299774691 Hz to 2299774648 Hz D0302 01:26:26.085392 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209053862341868 monotonicBaseRef:59000286994 monotonicFrequency:2299774652 realtimeReady:1 realtimeBaseCycles:9209053862930150 realtimeBaseRef:1583112386085208325 realtimeFrequency:2299774648} D0302 01:26:27.084816 47680 parameters.go:238] Clock(Monotonic): error: -147 ns, adjusted frequency from 2299774652 Hz to 2299774294 Hz D0302 01:26:27.084993 47680 parameters.go:238] Clock(Realtime): error: -127 ns, adjusted frequency from 2299774648 Hz to 2299774420 Hz D0302 01:26:27.085149 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209056161761674 monotonicBaseRef:60000132698 monotonicFrequency:2299774294 realtimeReady:1 realtimeBaseCycles:9209056162200365 realtimeBaseRef:1583112387084988984 realtimeFrequency:2299774420} D0302 01:26:28.085659 47680 parameters.go:238] Clock(Monotonic): error: 216 ns, adjusted frequency from 2299774294 Hz to 2299775217 Hz D0302 01:26:28.085929 47680 parameters.go:238] Clock(Realtime): error: -130 ns, adjusted frequency from 2299774420 Hz to 2299774419 Hz D0302 01:26:28.086219 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209058463454738 monotonicBaseRef:61000967027 monotonicFrequency:2299775217 realtimeReady:1 realtimeBaseCycles:9209058464119173 realtimeBaseRef:1583112388085921418 realtimeFrequency:2299774419} D0302 01:26:29.085004 47680 parameters.go:238] Clock(Monotonic): error: -179 ns, adjusted frequency from 2299775217 Hz to 2299774238 Hz I0302 01:26:29.085118 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:29.085212 47680 parameters.go:238] Clock(Realtime): error: 119 ns, adjusted frequency from 2299774419 Hz to 2299774915 Hz D0302 01:26:29.085399 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209060761670743 monotonicBaseRef:62000289042 monotonicFrequency:2299774238 realtimeReady:1 realtimeBaseCycles:9209060762248299 realtimeBaseRef:1583112389085206003 realtimeFrequency:2299774915} D0302 01:26:29.085974 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:29.086130 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:29.086183 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:29.086277 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:29.086428 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:29.086462 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:29.086585 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:29.086621 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:29.087033 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:29.087058 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:29.087163 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:29.087493 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:29.087656 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:30.084964 47680 parameters.go:238] Clock(Monotonic): error: 79 ns, adjusted frequency from 2299774238 Hz to 2299774817 Hz D0302 01:26:30.085175 47680 parameters.go:238] Clock(Realtime): error: 80 ns, adjusted frequency from 2299774915 Hz to 2299774734 Hz D0302 01:26:30.085355 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209063061427096 monotonicBaseRef:63000281265 monotonicFrequency:2299774817 realtimeReady:1 realtimeBaseCycles:9209063061938152 realtimeBaseRef:1583112390085169015 realtimeFrequency:2299774734} D0302 01:26:31.084975 47680 parameters.go:238] Clock(Monotonic): error: 218 ns, adjusted frequency from 2299774817 Hz to 2299775100 Hz D0302 01:26:31.085223 47680 parameters.go:238] Clock(Realtime): error: 122 ns, adjusted frequency from 2299774734 Hz to 2299774929 Hz D0302 01:26:31.085451 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209065361220877 monotonicBaseRef:64000289511 monotonicFrequency:2299775100 realtimeReady:1 realtimeBaseCycles:9209065361820084 realtimeBaseRef:1583112391085215627 realtimeFrequency:2299774929} I0302 01:26:31.086666 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:31.086871 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:31.087001 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:31.087152 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:31.087352 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:31.087486 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:31.333412 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:31.333709 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:31.333816 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:31.333948 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:31.333954 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:31.334043 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:31.334180 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:31.334313 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:32.084932 47680 parameters.go:238] Clock(Monotonic): error: -47 ns, adjusted frequency from 2299775100 Hz to 2299774630 Hz D0302 01:26:32.085197 47680 parameters.go:238] Clock(Realtime): error: -193 ns, adjusted frequency from 2299774929 Hz to 2299774275 Hz D0302 01:26:32.085394 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209067660900441 monotonicBaseRef:65000247969 monotonicFrequency:2299774630 realtimeReady:1 realtimeBaseCycles:9209067661536452 realtimeBaseRef:1583112392085190163 realtimeFrequency:2299774275} D0302 01:26:33.084995 47680 parameters.go:238] Clock(Monotonic): error: 73 ns, adjusted frequency from 2299774630 Hz to 2299774724 Hz I0302 01:26:33.085090 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:33.085237 47680 parameters.go:238] Clock(Realtime): error: 126 ns, adjusted frequency from 2299774275 Hz to 2299774916 Hz D0302 01:26:33.085347 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:33.085399 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209069960758678 monotonicBaseRef:66000284323 monotonicFrequency:2299774724 realtimeReady:1 realtimeBaseCycles:9209069961397081 realtimeBaseRef:1583112393085227711 realtimeFrequency:2299774916} D0302 01:26:33.085566 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:33.085706 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:33.085778 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:33.085916 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:33.086050 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:33.087230 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:34.084950 47680 parameters.go:238] Clock(Monotonic): error: -233 ns, adjusted frequency from 2299774724 Hz to 2299774102 Hz D0302 01:26:34.085255 47680 parameters.go:238] Clock(Realtime): error: -50 ns, adjusted frequency from 2299774916 Hz to 2299774568 Hz I0302 01:26:34.085371 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:34.085461 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209072260492332 monotonicBaseRef:67000266464 monotonicFrequency:2299774102 realtimeReady:1 realtimeBaseCycles:9209072261218796 realtimeBaseRef:1583112394085248060 realtimeFrequency:2299774568} D0302 01:26:34.085685 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:34.085858 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:34.085957 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:34.086035 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:34.086180 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:34.086375 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:34.086551 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:34.087206 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:34.087429 47680 task_signals.go:452] [ 2] Notified of group signal 23 D0302 01:26:34.087555 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:34.087715 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:34.087712 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:34.087851 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:34.087950 47680 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal D0302 01:26:35.084957 47680 parameters.go:238] Clock(Monotonic): error: 92 ns, adjusted frequency from 2299774102 Hz to 2299774860 Hz D0302 01:26:35.085218 47680 parameters.go:238] Clock(Realtime): error: 469 ns, adjusted frequency from 2299774568 Hz to 2299775767 Hz D0302 01:26:35.085353 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209074560287180 monotonicBaseRef:68000275484 monotonicFrequency:2299774860 realtimeReady:1 realtimeBaseCycles:9209074560908846 realtimeBaseRef:1583112395085211309 realtimeFrequency:2299775767} D0302 01:26:36.084957 47680 parameters.go:238] Clock(Monotonic): error: -177 ns, adjusted frequency from 2299774860 Hz to 2299774251 Hz D0302 01:26:36.085160 47680 parameters.go:238] Clock(Realtime): error: -380 ns, adjusted frequency from 2299775767 Hz to 2299773774 Hz D0302 01:26:36.085274 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209076860051488 monotonicBaseRef:69000270895 monotonicFrequency:2299774251 realtimeReady:1 realtimeBaseCycles:9209076860550608 realtimeBaseRef:1583112396085153040 realtimeFrequency:2299773774} I0302 01:26:36.333106 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:36.333399 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:36.333524 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:36.333641 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:36.333732 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:36.333878 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:36.333946 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:36.334001 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:36.334065 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:36.334539 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:36.334641 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:36.334763 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:36.335011 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:36.335136 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 01:26:36.345136 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:36.345408 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:36.345576 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:36.345700 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:36.345903 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:36.346045 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:37.085134 47680 parameters.go:238] Clock(Monotonic): error: 127 ns, adjusted frequency from 2299774251 Hz to 2299774956 Hz I0302 01:26:37.085384 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:37.085381 47680 parameters.go:238] Clock(Realtime): error: 40 ns, adjusted frequency from 2299773774 Hz to 2299774687 Hz D0302 01:26:37.085637 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:37.085614 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209079160246083 monotonicBaseRef:70000453671 monotonicFrequency:2299774956 realtimeReady:1 realtimeBaseCycles:9209079160833462 realtimeBaseRef:1583112397085374400 realtimeFrequency:2299774687} D0302 01:26:37.085840 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:37.086003 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:37.086022 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:37.086178 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:37.086366 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:37.086567 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:37.333177 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:37.333435 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:37.333571 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:37.333708 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:37.334002 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:37.334283 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:38.084972 47680 parameters.go:238] Clock(Monotonic): error: 8 ns, adjusted frequency from 2299774956 Hz to 2299774672 Hz I0302 01:26:38.085089 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:38.085288 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:38.085230 47680 parameters.go:238] Clock(Realtime): error: -22 ns, adjusted frequency from 2299774687 Hz to 2299774615 Hz D0302 01:26:38.085398 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:38.085424 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209081459576573 monotonicBaseRef:71000260406 monotonicFrequency:2299774672 realtimeReady:1 realtimeBaseCycles:9209081460261057 realtimeBaseRef:1583112398085223475 realtimeFrequency:2299774615} D0302 01:26:38.085579 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:38.085831 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:38.085974 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:38.333945 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:38.334218 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:38.334401 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:38.334472 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:38.334599 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:38.334768 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:38.334759 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:38.334868 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:38.334885 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:38.335424 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:38.335534 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:38.335548 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:38.335762 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:38.335963 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:39.084973 47680 parameters.go:238] Clock(Monotonic): error: -133 ns, adjusted frequency from 2299774672 Hz to 2299774361 Hz D0302 01:26:39.085204 47680 parameters.go:238] Clock(Realtime): error: -249 ns, adjusted frequency from 2299774615 Hz to 2299774110 Hz D0302 01:26:39.085337 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209083759421982 monotonicBaseRef:72000291164 monotonicFrequency:2299774361 realtimeReady:1 realtimeBaseCycles:9209083759978270 realtimeBaseRef:1583112399085198515 realtimeFrequency:2299774110} D0302 01:26:40.084923 47680 parameters.go:238] Clock(Monotonic): error: 233 ns, adjusted frequency from 2299774361 Hz to 2299775078 Hz D0302 01:26:40.085079 47680 parameters.go:238] Clock(Realtime): error: -83 ns, adjusted frequency from 2299774110 Hz to 2299774478 Hz D0302 01:26:40.085214 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209086059061603 monotonicBaseRef:73000232575 monotonicFrequency:2299775078 realtimeReady:1 realtimeBaseCycles:9209086059467621 realtimeBaseRef:1583112400085074694 realtimeFrequency:2299774478} I0302 01:26:40.333063 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:40.333315 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:40.333434 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:40.333638 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:40.333855 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:40.334065 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:40.345011 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:40.345225 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:40.345327 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:40.345388 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:40.345739 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:40.345916 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:41.084878 47680 parameters.go:238] Clock(Monotonic): error: -3 ns, adjusted frequency from 2299775078 Hz to 2299774645 Hz D0302 01:26:41.085163 47680 parameters.go:238] Clock(Realtime): error: 150 ns, adjusted frequency from 2299774478 Hz to 2299774930 Hz I0302 01:26:41.085097 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:41.085428 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:41.085291 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209088358752097 monotonicBaseRef:74000195795 monotonicFrequency:2299774645 realtimeReady:1 realtimeBaseCycles:9209088359429834 realtimeBaseRef:1583112401085156325 realtimeFrequency:2299774930} D0302 01:26:41.085545 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:41.085586 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:41.085797 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:41.085974 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:41.333121 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:41.333979 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:41.334154 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:41.334277 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:41.334354 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:41.334465 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:41.334518 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:41.334621 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:41.334681 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:41.335142 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:41.335180 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:41.335265 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:41.335461 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:41.335603 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:42.084971 47680 parameters.go:238] Clock(Monotonic): error: -62 ns, adjusted frequency from 2299774645 Hz to 2299774595 Hz D0302 01:26:42.085184 47680 parameters.go:238] Clock(Realtime): error: 117 ns, adjusted frequency from 2299774930 Hz to 2299774972 Hz D0302 01:26:42.085311 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209090658737535 monotonicBaseRef:75000287453 monotonicFrequency:2299774595 realtimeReady:1 realtimeBaseCycles:9209090659252408 realtimeBaseRef:1583112402085177041 realtimeFrequency:2299774972} I0302 01:26:42.333091 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:42.333338 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:42.333477 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:42.333599 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:42.333761 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:42.333861 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:43.085046 47680 parameters.go:238] Clock(Monotonic): error: 103 ns, adjusted frequency from 2299774595 Hz to 2299774879 Hz I0302 01:26:43.085130 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:43.085257 47680 parameters.go:238] Clock(Realtime): error: -258 ns, adjusted frequency from 2299774972 Hz to 2299774021 Hz D0302 01:26:43.085370 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:43.085395 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209092958651820 monotonicBaseRef:76000348193 monotonicFrequency:2299774879 realtimeReady:1 realtimeBaseCycles:9209092959197267 realtimeBaseRef:1583112403085250912 realtimeFrequency:2299774021} D0302 01:26:43.085561 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:43.085658 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:43.085912 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:43.086041 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:43.333090 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:43.333326 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:43.333436 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:43.333594 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:43.333662 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:43.333783 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:43.333949 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0302 01:26:43.334025 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:43.334134 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:43.334202 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:43.334387 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:43.334649 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:43.334810 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:43.334778 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:43.335172 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:43.335311 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:44.084904 47680 parameters.go:238] Clock(Monotonic): error: -290 ns, adjusted frequency from 2299774879 Hz to 2299773969 Hz D0302 01:26:44.085150 47680 parameters.go:238] Clock(Realtime): error: 154 ns, adjusted frequency from 2299774021 Hz to 2299774934 Hz D0302 01:26:44.085265 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209095258124527 monotonicBaseRef:77000216801 monotonicFrequency:2299773969 realtimeReady:1 realtimeBaseCycles:9209095258725334 realtimeBaseRef:1583112404085143964 realtimeFrequency:2299774934} D0302 01:26:45.084969 47680 parameters.go:238] Clock(Monotonic): error: 258 ns, adjusted frequency from 2299773969 Hz to 2299775233 Hz D0302 01:26:45.085246 47680 parameters.go:238] Clock(Realtime): error: 221 ns, adjusted frequency from 2299774934 Hz to 2299775138 Hz D0302 01:26:45.085390 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209097558050254 monotonicBaseRef:78000282789 monotonicFrequency:2299775233 realtimeReady:1 realtimeBaseCycles:9209097558717603 realtimeBaseRef:1583112405085238466 realtimeFrequency:2299775138} I0302 01:26:45.333551 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:45.333895 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:45.334047 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:45.334197 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:45.334197 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:45.334339 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:45.334563 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:45.334726 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:45.334794 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:45.335028 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:45.335133 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:45.335367 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:45.335495 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:45.335480 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:45.335728 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:45.335868 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:46.085285 47680 parameters.go:238] Clock(Monotonic): error: 73 ns, adjusted frequency from 2299775233 Hz to 2299774741 Hz D0302 01:26:46.085600 47680 parameters.go:238] Clock(Realtime): error: -9 ns, adjusted frequency from 2299775138 Hz to 2299774659 Hz I0302 01:26:46.085716 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:46.085755 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209099858561142 monotonicBaseRef:79000602670 monotonicFrequency:2299774741 realtimeReady:1 realtimeBaseCycles:9209099859290587 realtimeBaseRef:1583112406085585389 realtimeFrequency:2299774659} D0302 01:26:46.086188 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:46.086375 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:46.086557 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:46.086540 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:46.086761 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:46.087015 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:46.087156 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:47.084920 47680 parameters.go:238] Clock(Monotonic): error: -180 ns, adjusted frequency from 2299774741 Hz to 2299774239 Hz D0302 01:26:47.085624 47680 parameters.go:238] Clock(Realtime): error: -22 ns, adjusted frequency from 2299774659 Hz to 2299774619 Hz D0302 01:26:47.085785 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209102157482716 monotonicBaseRef:80000231691 monotonicFrequency:2299774239 realtimeReady:1 realtimeBaseCycles:9209102159125790 realtimeBaseRef:1583112407085611715 realtimeFrequency:2299774619} I0302 01:26:47.086218 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:47.086438 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:47.086551 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:47.087031 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:47.087370 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:47.087519 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:47.333455 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:47.333727 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:47.333835 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:47.333999 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:47.334096 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:47.334029 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:47.334275 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:47.334463 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:48.084864 47680 parameters.go:238] Clock(Monotonic): error: 115 ns, adjusted frequency from 2299774239 Hz to 2299774931 Hz D0302 01:26:48.085133 47680 parameters.go:238] Clock(Realtime): error: 20 ns, adjusted frequency from 2299774619 Hz to 2299774677 Hz D0302 01:26:48.085322 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209104457129854 monotonicBaseRef:81000176424 monotonicFrequency:2299774931 realtimeReady:1 realtimeBaseCycles:9209104457778685 realtimeBaseRef:1583112408085123961 realtimeFrequency:2299774677} D0302 01:26:49.084960 47680 parameters.go:238] Clock(Monotonic): error: -67 ns, adjusted frequency from 2299774931 Hz to 2299774637 Hz D0302 01:26:49.085293 47680 parameters.go:238] Clock(Realtime): error: -246 ns, adjusted frequency from 2299774677 Hz to 2299774132 Hz D0302 01:26:49.085564 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209106757122904 monotonicBaseRef:82000271267 monotonicFrequency:2299774637 realtimeReady:1 realtimeBaseCycles:9209106757922957 realtimeBaseRef:1583112409085284670 realtimeFrequency:2299774132} D0302 01:26:50.085703 47680 parameters.go:238] Clock(Monotonic): error: 20 ns, adjusted frequency from 2299774637 Hz to 2299774679 Hz I0302 01:26:50.085972 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:50.086061 47680 parameters.go:238] Clock(Realtime): error: 205 ns, adjusted frequency from 2299774132 Hz to 2299775098 Hz D0302 01:26:50.086278 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:50.086412 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209109058466681 monotonicBaseRef:83000953568 monotonicFrequency:2299774679 realtimeReady:1 realtimeBaseCycles:9209109059463806 realtimeBaseRef:1583112410086052883 realtimeFrequency:2299775098} D0302 01:26:50.086497 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:50.086589 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:50.086785 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:50.086939 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:50.086935 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:50.087028 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:50.087153 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:50.087727 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:50.087768 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:50.088035 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:50.088338 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:50.088475 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:51.084989 47680 parameters.go:238] Clock(Monotonic): error: 231 ns, adjusted frequency from 2299774679 Hz to 2299775065 Hz I0302 01:26:51.085162 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:51.085284 47680 parameters.go:238] Clock(Realtime): error: -159 ns, adjusted frequency from 2299775098 Hz to 2299774256 Hz D0302 01:26:51.085456 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:51.085435 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209111356741517 monotonicBaseRef:84000301398 monotonicFrequency:2299775065 realtimeReady:1 realtimeBaseCycles:9209111357455417 realtimeBaseRef:1583112411085277378 realtimeFrequency:2299774256} D0302 01:26:51.085602 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:51.085642 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:51.085785 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:51.085891 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:51.086072 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:51.086375 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:51.096990 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:51.097213 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:51.097400 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:51.097476 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:51.097705 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:51.097865 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:52.085042 47680 parameters.go:238] Clock(Monotonic): error: -297 ns, adjusted frequency from 2299775065 Hz to 2299773984 Hz I0302 01:26:52.085115 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.085269 47680 parameters.go:238] Clock(Realtime): error: 270 ns, adjusted frequency from 2299774256 Hz to 2299775312 Hz D0302 01:26:52.085354 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:52.085455 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209113656639098 monotonicBaseRef:85000354671 monotonicFrequency:2299773984 realtimeReady:1 realtimeBaseCycles:9209113657194347 realtimeBaseRef:1583112412085262017 realtimeFrequency:2299775312} D0302 01:26:52.085540 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.085565 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:52.085726 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.085866 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:52.085861 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:52.085950 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.086008 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:52.086402 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:52.086482 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:52.086596 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.086758 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:52.086898 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 01:26:52.854904 50227 main.go:305] *************************** I0302 01:26:52.855085 50227 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-0 /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller091837627] I0302 01:26:52.855620 50227 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0302 01:26:52.855696 50227 main.go:308] PID: 50227 I0302 01:26:52.855814 50227 main.go:309] UID: 0, GID: 0 I0302 01:26:52.855944 50227 main.go:310] Configuration: I0302 01:26:52.856031 50227 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0302 01:26:52.856103 50227 main.go:312] Platform: ptrace I0302 01:26:52.856208 50227 main.go:313] FileAccess: shared, overlay: false I0302 01:26:52.856332 50227 main.go:314] Network: sandbox, logging: false I0302 01:26:52.856413 50227 main.go:315] Strace: false, max size: 1024, syscalls: [] I0302 01:26:52.856532 50227 main.go:316] *************************** W0302 01:26:52.856677 50227 main.go:321] Block the TERM signal. This is only safe in tests! D0302 01:26:52.857101 50227 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.866028 50227 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0302 01:26:52.866160 50227 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.866287 50227 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.866836 50227 urpc.go:534] urpc: successfully marshalled 117 bytes. I0302 01:26:52.868353 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.868776 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:52.868993 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.868940 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:52.869406 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.869428 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:52.869615 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:52.869765 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:52.869572 47680 urpc.go:577] urpc: unmarshal success. D0302 01:26:52.869901 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.870087 47680 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0302 01:26:52.870334 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:52.870282 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:52.870538 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.870934 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 I0302 01:26:52.871053 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.871207 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:52.871201 47680 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 01:26:52.871453 50227 urpc.go:577] urpc: unmarshal success. D0302 01:26:52.871617 50227 exec.go:120] Exec arguments: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller091837627 D0302 01:26:52.871768 50227 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0302 01:26:52.872005 50227 container.go:533] Execute in container "ci-gvisor-ptrace-proxy-sandbox-race-0", args: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller091837627 D0302 01:26:52.871269 47680 task_signals.go:452] [ 2] Notified of group signal 23 D0302 01:26:52.872241 50227 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-0" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.872414 47680 task_block.go:223] [ 2] Interrupt queued I0302 01:26:52.872598 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.872595 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:26:52.872676 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:26:52.872741 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:52.872421 50227 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.872863 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.873008 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:52.873210 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:52.873271 47680 task_run.go:155] [ 3] Restarting syscall 202 after errno 512: not interrupted by handled signal D0302 01:26:52.874134 50227 urpc.go:534] urpc: successfully marshalled 634 bytes. D0302 01:26:52.874501 47680 urpc.go:577] urpc: unmarshal success. D0302 01:26:52.875806 47680 controller.go:267] containerManager.ExecuteAsync: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller091837627 D0302 01:26:52.876086 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0302 01:26:52.877189 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:52.877379 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 01:26:52.877970 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} I0302 01:26:52.878918 47680 kernel.go:797] EXEC: [/syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller091837627] D0302 01:26:52.879834 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0302 01:26:52.881107 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] 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: 1583112328, NanoSec: 447471369}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 17703713}]} D0302 01:26:52.881957 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0302 01:26:52.882427 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:52.883056 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} I0302 01:26:52.884697 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.884727 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 17703713}, 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: 1583112328, NanoSec: 447471369}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0302 01:26:52.884957 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalk{FID: 5, NewFID: 6, Names: []} D0302 01:26:52.885557 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rwalk{QIDs: []} D0302 01:26:52.885849 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tlopen{FID: 6, Flags: ReadOnly} D0302 01:26:52.887139 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 17703713}, IoUnit: 0, File: &{{36}}} D0302 01:26:52.893712 47680 syscalls.go:266] Allocating stack with size of 8388608 bytes D0302 01:26:52.895374 47680 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-0 0}:0xc00034eaa0 {ci-gvisor-ptrace-proxy-sandbox-race-0 21}:0xc00034e020] D0302 01:26:52.896233 50227 urpc.go:577] urpc: unmarshal success. D0302 01:26:52.896458 50227 container.go:580] Wait on PID 21 in container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.895932 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:52.896015 47680 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 01:26:52.896101 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.896143 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:52.896248 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:52.896397 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:52.896500 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.896358 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:52.896659 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:52.896676 50227 sandbox.go:761] Waiting for PID 21 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.896826 50227 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:52.897149 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:52.897202 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:52.897279 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:52.897429 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:52.897549 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:52.897599 50227 urpc.go:534] urpc: successfully marshalled 100 bytes. D0302 01:26:52.897837 47680 urpc.go:577] urpc: unmarshal success. D0302 01:26:52.898120 47680 controller.go:443] containerManager.Wait D0302 01:26:52.904731 47680 task_block.go:223] [ 21] Interrupt queued D0302 01:26:53.084918 47680 parameters.go:238] Clock(Monotonic): error: 193 ns, adjusted frequency from 2299773984 Hz to 2299774951 Hz D0302 01:26:53.085167 47680 parameters.go:238] Clock(Realtime): error: -403 ns, adjusted frequency from 2299775312 Hz to 2299773729 Hz D0302 01:26:53.085364 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209115956105755 monotonicBaseRef:86000221037 monotonicFrequency:2299774951 realtimeReady:1 realtimeBaseCycles:9209115956723514 realtimeBaseRef:1583112413085154986 realtimeFrequency:2299773729} I0302 01:26:53.126255 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.126458 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.126582 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.126615 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.126803 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.126937 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.141567 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.141789 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.142149 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.142203 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.142460 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.142628 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.147480 47680 task_block.go:223] [ 22] Interrupt queued D0302 01:26:53.148287 47680 task_block.go:223] [ 23] Interrupt queued D0302 01:26:53.172024 47680 task_block.go:223] [ 24] Interrupt queued D0302 01:26:53.183261 47680 task_block.go:223] [ 25] Interrupt queued D0302 01:26:53.215466 47680 task_block.go:223] [ 26] Interrupt queued D0302 01:26:53.229502 47680 task_block.go:223] [ 27] Interrupt queued D0302 01:26:53.247995 47680 urpc.go:577] urpc: unmarshal success. D0302 01:26:53.248416 47680 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0302 01:26:53.248738 47680 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 01:26:53.249541 47680 task_block.go:223] [ 28] Interrupt queued D0302 01:26:53.279815 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0302 01:26:53.280727 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.280889 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 01:26:53.281586 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} I0302 01:26:53.303696 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.303973 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.304118 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.304311 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.304734 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.304873 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.306511 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.306942 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.307136 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:53.307383 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.307567 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0302 01:26:53.307856 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.308019 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0302 01:26:53.308346 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.309450 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0302 01:26:53.309618 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.309705 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:53.309785 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.310006 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.310122 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.329097 47680 task_block.go:223] [ 29] Interrupt queued D0302 01:26:53.350535 47680 task_block.go:223] [ 30] Interrupt queued D0302 01:26:53.360247 47680 task_block.go:223] [ 31] Interrupt queued D0302 01:26:53.367267 47680 task_block.go:223] [ 32] Interrupt queued D0302 01:26:53.402864 47680 task_block.go:223] [ 33] Interrupt queued D0302 01:26:53.416156 47680 task_block.go:223] [ 34] Interrupt queued I0302 01:26:53.428103 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.428375 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.428550 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.428978 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.429187 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.429333 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.475502 47680 task_block.go:223] [ 35] Interrupt queued D0302 01:26:53.486753 47680 task_block.go:223] [ 36] Interrupt queued D0302 01:26:53.487935 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller091837627]} D0302 01:26:53.489611 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] 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: 1172, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583112412, NanoSec: 811737300}, MTime: {Sec: 1583112412, NanoSec: 811737300}, CTime: {Sec: 1583112412, NanoSec: 811737300}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 17703692}]} D0302 01:26:53.489855 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller091837627, Size: 1} D0302 01:26:53.490479 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.490830 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 01:26:53.491921 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 17703692}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1172, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583112412, NanoSec: 811737300}, MTime: {Sec: 1583112412, NanoSec: 811737300}, CTime: {Sec: 1583112412, NanoSec: 811737300}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0302 01:26:53.492206 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalk{FID: 7, NewFID: 8, Names: []} D0302 01:26:53.493119 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rwalk{QIDs: []} D0302 01:26:53.493300 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tlopen{FID: 8, Flags: ReadOnly} D0302 01:26:53.494505 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 17703692}, IoUnit: 0, File: &{{30}}} D0302 01:26:53.495721 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 01:26:53.496935 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 17703692}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1172, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583112412, NanoSec: 811737300}, MTime: {Sec: 1583112412, NanoSec: 811737300}, CTime: {Sec: 1583112412, NanoSec: 811737300}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/02 01:26:53 parsed 1 programs I0302 01:26:53.503090 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.503385 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.503570 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.503684 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.504013 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.504163 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.512150 47680 task_stop.go:118] [ 35] Entering internal stop (*kernel.vforkStop)(nil) D0302 01:26:53.512975 47680 task_block.go:223] [ 37] Interrupt queued D0302 01:26:53.517782 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0302 01:26:53.520035 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] 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: 1583112328, NanoSec: 451471761}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 17703732}]} D0302 01:26:53.520496 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0302 01:26:53.521102 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.521459 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 01:26:53.522643 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 17703732}, 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: 1583112328, NanoSec: 451471761}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0302 01:26:53.522780 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalk{FID: 9, NewFID: 10, Names: []} D0302 01:26:53.523749 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rwalk{QIDs: []} D0302 01:26:53.523960 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tlopen{FID: 10, Flags: ReadOnly} I0302 01:26:53.523987 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.524310 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.524450 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.524515 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.524812 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.525062 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 17703732}, IoUnit: 0, File: &{{31}}} D0302 01:26:53.525042 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.526894 47680 syscalls.go:266] [ 37] Allocating stack with size of 8388608 bytes D0302 01:26:53.527758 47680 task_stop.go:137] [ 35] Leaving internal stop (*kernel.vforkStop)(nil) I0302 01:26:53.552208 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.552444 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.552596 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.552641 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.552852 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.553015 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.554942 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.555716 47680 task_signals.go:452] [ 2] Notified of group signal 23 D0302 01:26:53.555873 47680 task_block.go:223] [ 2] Interrupt queued I0302 01:26:53.556143 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.556299 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:53.556304 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:53.557725 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 I0302 01:26:53.557766 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.557957 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:53.558015 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.558228 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.558400 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.558596 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.558735 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.561451 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0302 01:26:53.562271 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.562510 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 01:26:53.563109 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.564879 47680 task_exit.go:221] [ 37] Transitioning from exit state TaskExitNone to TaskExitInitiated D0302 01:26:53.566213 47680 task_exit.go:221] [ 37] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0302 01:26:53.566372 47680 task_signals.go:446] [ 21] Notified of signal 17 D0302 01:26:53.566562 47680 task_block.go:223] [ 21] Interrupt queued D0302 01:26:53.566993 47680 task_block.go:223] [ 21] Interrupt queued D0302 01:26:53.567216 47680 task_signals.go:179] [ 21] Restarting syscall 202 after errno 512: interrupted by signal 17 D0302 01:26:53.567387 47680 task_signals.go:220] [ 21] Signal 17: delivering to handler D0302 01:26:53.567792 47680 task_exit.go:221] [ 37] Transitioning from exit state TaskExitZombie to TaskExitDead D0302 01:26:53.569976 47680 task_block.go:223] [ 38] Interrupt queued D0302 01:26:53.576918 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0302 01:26:53.578675 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] 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: 1583112328, NanoSec: 451471761}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 17703732}]} D0302 01:26:53.578905 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tclunk{FID: 11} D0302 01:26:53.579541 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rclunk{} D0302 01:26:53.579914 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 01:26:53.581148 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 17703732}, 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: 1583112328, NanoSec: 451471761}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/02 01:26:53 executed programs: 0 D0302 01:26:53.590594 47680 task_stop.go:118] [ 24] Entering internal stop (*kernel.vforkStop)(nil) D0302 01:26:53.591503 47680 task_block.go:223] [ 39] Interrupt queued D0302 01:26:53.597805 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0302 01:26:53.599786 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] 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: 1583112328, NanoSec: 451471761}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 17703732}]} D0302 01:26:53.599995 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tclunk{FID: 11} D0302 01:26:53.600486 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rclunk{} D0302 01:26:53.600772 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 01:26:53.601829 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 17703732}, 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: 1583112328, NanoSec: 451471761}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} I0302 01:26:53.601829 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.602083 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.602219 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.602254 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.602524 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.602661 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.603012 47680 syscalls.go:266] [ 39] Allocating stack with size of 8388608 bytes D0302 01:26:53.603953 47680 task_stop.go:137] [ 24] Leaving internal stop (*kernel.vforkStop)(nil) D0302 01:26:53.618118 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0302 01:26:53.618907 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.619089 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 01:26:53.619830 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} I0302 01:26:53.622099 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.622316 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.622432 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.622566 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.622796 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.622980 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.635188 47680 task_block.go:223] [ 40] Interrupt queued D0302 01:26:53.642567 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.643421 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.643616 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.644387 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.644851 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.645739 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.645971 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.646549 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.647098 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.647747 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.647953 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.648506 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.649087 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.649749 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.649945 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.650436 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.650935 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.651735 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.652013 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.652652 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} I0302 01:26:53.652772 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.652993 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.653159 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.653327 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.653452 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.653505 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.653656 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.654064 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.654271 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.654757 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.655177 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.656054 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.656343 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.657026 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.657386 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.657981 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.658138 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.658723 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.659407 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.660083 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.660228 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.660762 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} I0302 01:26:53.664652 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.664880 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.665060 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.665088 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.665267 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.665400 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.680722 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.680946 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.681056 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.681198 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.681461 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.681594 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.699601 47680 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0302 01:26:53.699764 47680 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 0 D0302 01:26:53.699954 47680 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 0 D0302 01:26:53.700181 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target I0302 01:26:53.700410 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.700654 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.700825 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.701017 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.700344 47680 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]} D0302 01:26:53.701282 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.701341 47680 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0302 01:26:53.701451 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.701495 47680 netfilter.go:54] netfilter: convert to binary: found hook 2 at offset 152 D0302 01:26:53.701663 47680 netfilter.go:54] netfilter: convert to binary: found underflow 2 at offset 152 D0302 01:26:53.701759 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 01:26:53.701893 47680 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]} D0302 01:26:53.703007 47680 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0302 01:26:53.703152 47680 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0302 01:26:53.703296 47680 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0302 01:26:53.703450 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 01:26:53.703552 47680 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]} D0302 01:26:53.704088 47680 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0302 01:26:53.704216 47680 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]} D0302 01:26:53.705018 47680 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0302 01:26:53.705159 47680 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0302 01:26:53.705243 47680 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0302 01:26:53.705381 47680 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0302 01:26:53.705529 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 01:26:53.705674 47680 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]} D0302 01:26:53.706309 47680 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0302 01:26:53.706447 47680 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 152 D0302 01:26:53.706577 47680 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 152 D0302 01:26:53.706677 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 01:26:53.706823 47680 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]} D0302 01:26:53.707532 47680 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0302 01:26:53.707624 47680 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0302 01:26:53.707765 47680 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0302 01:26:53.707835 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 01:26:53.707954 47680 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]} D0302 01:26:53.709345 47680 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0302 01:26:53.709470 47680 netfilter.go:54] netfilter: convert to binary: found hook 4 at offset 456 D0302 01:26:53.709599 47680 netfilter.go:54] netfilter: convert to binary: found underflow 4 at offset 456 D0302 01:26:53.709683 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target I0302 01:26:53.710305 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.710656 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.710781 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.709767 47680 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]} D0302 01:26:53.711081 47680 netfilter.go:54] netfilter: convert to binary: current offset: 608 D0302 01:26:53.711234 47680 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]} D0302 01:26:53.712055 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.712260 47680 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0302 01:26:53.712348 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.712439 47680 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0302 01:26:53.712564 47680 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0302 01:26:53.712674 47680 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0302 01:26:53.712542 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.712799 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 01:26:53.712960 47680 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]} D0302 01:26:53.713781 47680 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0302 01:26:53.713980 47680 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 152 D0302 01:26:53.714134 47680 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 152 D0302 01:26:53.714213 47680 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 01:26:53.714385 47680 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]} D0302 01:26:53.715135 47680 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0302 01:26:53.715285 47680 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]} D0302 01:26:53.716170 47680 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 I0302 01:26:53.719716 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.720110 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.721252 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.721280 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:53.721403 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.721520 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.721575 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.721622 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.721668 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.722036 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:53.722172 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.722149 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:53.722422 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 01:26:53.722590 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 01:26:53.733284 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.733519 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.733677 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.733811 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.734106 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.734256 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.749060 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.749253 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.749388 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.749437 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.749702 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.749880 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.760106 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.760312 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.760417 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.760538 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.760654 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.760791 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.775695 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.775988 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.776103 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.776167 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.776457 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.776630 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.795962 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.796234 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.796385 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.796517 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.797057 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.797204 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.816027 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.816227 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.816351 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.816466 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.816589 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.816711 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.836416 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.836672 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.836814 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.836855 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.837069 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.837240 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.856831 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.857118 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.857274 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.857436 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.857678 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.857821 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.877071 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.877293 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.877513 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.877550 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.877790 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.877971 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.897390 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.897617 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.897796 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.897938 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.898121 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.898250 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.917712 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.917974 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.918121 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.918249 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.918710 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.918840 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:53.929734 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.929928 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.930003 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.930213 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.930263 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.930453 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.930571 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.932244 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.932466 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.933081 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.933451 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.934345 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.934569 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.935155 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.935456 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.936111 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.936393 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.936974 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.937407 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.938014 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.938224 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.938728 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.939011 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.939630 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.939809 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.940358 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.940630 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.941284 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.941538 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.942043 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.942327 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.970393 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} I0302 01:26:53.970538 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.970756 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.970718 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.970864 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:53.971022 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.971000 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.971135 47680 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 01:26:53.971241 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.971416 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:53.975243 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.975689 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.976383 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.976564 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.977330 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.977670 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.978338 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.978487 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.979077 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} D0302 01:26:53.979362 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 01:26:53.979958 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 2} D0302 01:26:53.980148 47680 transport_flipcall.go:127] send [channel @0xc00041a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 01:26:53.980864 47680 transport_flipcall.go:234] recv [channel @0xc00041a3c0] Rlerror{Error: 95} I0302 01:26:53.982429 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:53.982729 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:53.983048 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.983105 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:53.983340 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:53.983487 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:54.004126 47680 task_block.go:223] [ 41] Interrupt queued I0302 01:26:54.016197 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.016590 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.016730 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.016823 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:54.017000 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.017175 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:54.017226 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.017317 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:54.017484 47680 task_block.go:223] [ 1] Interrupt queued I0302 01:26:54.017904 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.018152 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:54.018170 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:54.018344 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.018650 47680 task_signals.go:452] [ 2] Notified of group signal 23 D0302 01:26:54.020395 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:54.020341 47680 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 I0302 01:26:54.020577 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.020595 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:54.020669 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.020858 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:54.021017 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.021153 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.021372 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:26:54.021386 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:26:54.021533 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:54.021705 47680 task_block.go:223] [ 3] Interrupt queued D0302 01:26:54.021836 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.022113 47680 task_block.go:223] [ 2] Interrupt queued D0302 01:26:54.022246 47680 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 01:26:54.022420 47680 task_run.go:155] [ 3] Restarting syscall 202 after errno 512: not interrupted by handled signal D0302 01:26:54.028658 47680 task_block.go:223] [ 42] Interrupt queued I0302 01:26:54.074683 47680 compat.go:122] Unsupported syscall: setsockopt, regs: amd64: D0302 01:26:54.084831 47680 parameters.go:238] Clock(Monotonic): error: -105 ns, adjusted frequency from 2299774951 Hz to 2299774406 Hz D0302 01:26:54.085173 47680 parameters.go:238] Clock(Realtime): error: -65 ns, adjusted frequency from 2299773729 Hz to 2299774549 Hz D0302 01:26:54.085354 47680 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9209118255716822 monotonicBaseRef:87000149776 monotonicFrequency:2299774406 realtimeReady:1 realtimeBaseCycles:9209118256491526 realtimeBaseRef:1583112414085152500 realtimeFrequency:2299774549} I0302 01:26:54.157010 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.157254 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.157351 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.157523 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.157801 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:54.157977 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:54.505273 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.505608 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.505773 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.505792 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.506046 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:54.506159 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:54.555774 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.556043 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.556174 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.556266 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.556490 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:54.556591 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:54.705703 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.705957 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.706171 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.706408 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.706609 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:54.706783 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 01:26:54.752904 47680 loader.go:566] Received external signal 23, mode: Process D0302 01:26:54.753239 47680 task_signals.go:446] [ 1] Notified of signal 23 D0302 01:26:54.753404 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.753591 47680 task_block.go:223] [ 1] Interrupt queued D0302 01:26:54.753854 47680 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 01:26:54.754076 47680 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 01:26:54.832906 47680 task_block.go:223] [ 43] Interrupt queued D0302 01:26:54.838816 47680 task_block.go:223] [ 44] Interrupt queued D0302 01:26:54.851393 47680 task_block.go:223] [ 45] Interrupt queued ================== WARNING: DATA RACE Write at 0x00c0004184f8 by goroutine 364: gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).fetchReadView() pkg/sentry/socket/netstack/netstack.go:418 +0x85 gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).nonBlockingRead() pkg/sentry/socket/netstack/netstack.go:2388 +0x169 gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).RecvMsg() pkg/sentry/socket/netstack/netstack.go:2535 +0x715 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.recvFrom() pkg/sentry/syscalls/linux/sys_socket.go:871 +0x345 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.RecvFrom() pkg/sentry/syscalls/linux/sys_socket.go:896 +0x88 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 DIAGNOSIS: I0302 01:26:54.908932 50392 main.go:305] *************************** I0302 01:26:54.909137 50392 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-0] I0302 01:26:54.909356 50392 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0302 01:26:54.909444 50392 main.go:308] PID: 50392 I0302 01:26:54.909562 50392 main.go:309] UID: 0, GID: 0 I0302 01:26:54.909629 50392 main.go:310] Configuration: I0302 01:26:54.909713 50392 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0302 01:26:54.909833 50392 main.go:312] Platform: ptrace I0302 01:26:54.909937 50392 main.go:313] FileAccess: shared, overlay: false I0302 01:26:54.910025 50392 main.go:314] Network: sandbox, logging: false I0302 01:26:54.910132 50392 main.go:315] Strace: false, max size: 1024, syscalls: [] I0302 01:26:54.910226 50392 main.go:316] *************************** W0302 01:26:54.910303 50392 main.go:321] Block the TERM signal. This is only safe in tests! D0302 01:26:54.910472 50392 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.917348 50392 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0302 01:26:54.917576 50392 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.917692 50392 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.918202 50392 urpc.go:534] urpc: successfully marshalled 117 bytes. I0302 01:26:54.995982 50392 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 47680 I0302 01:26:54.996149 50392 debug.go:131] Retrieving sandbox stacks D0302 01:26:54.996251 50392 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.996345 50392 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0302 01:26:54.996523 50392 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 47680: connection refused retrieving stacks: connecting to control server at PID 47680: connection refused W0302 01:26:54.996867 50392 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-0"]: exit status 128 I0302 01:26:54.908932 50392 main.go:305] *************************** I0302 01:26:54.909137 50392 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-0] I0302 01:26:54.909356 50392 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0302 01:26:54.909444 50392 main.go:308] PID: 50392 I0302 01:26:54.909562 50392 main.go:309] UID: 0, GID: 0 I0302 01:26:54.909629 50392 main.go:310] Configuration: I0302 01:26:54.909713 50392 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0302 01:26:54.909833 50392 main.go:312] Platform: ptrace I0302 01:26:54.909937 50392 main.go:313] FileAccess: shared, overlay: false I0302 01:26:54.910025 50392 main.go:314] Network: sandbox, logging: false I0302 01:26:54.910132 50392 main.go:315] Strace: false, max size: 1024, syscalls: [] I0302 01:26:54.910226 50392 main.go:316] *************************** W0302 01:26:54.910303 50392 main.go:321] Block the TERM signal. This is only safe in tests! D0302 01:26:54.910472 50392 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.917348 50392 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0302 01:26:54.917576 50392 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.917692 50392 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.918202 50392 urpc.go:534] urpc: successfully marshalled 117 bytes. I0302 01:26:54.995982 50392 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 47680 I0302 01:26:54.996149 50392 debug.go:131] Retrieving sandbox stacks D0302 01:26:54.996251 50392 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.996345 50392 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0302 01:26:54.996523 50392 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 47680: connection refused retrieving stacks: connecting to control server at PID 47680: connection refused W0302 01:26:54.996867 50392 main.go:338] Failure to execute command, err: 1 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 0x00c0004184f8 by goroutine 357: gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).Ioctl() pkg/sentry/socket/netstack/netstack.go:2666 +0x533 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Ioctl() pkg/sentry/syscalls/linux/sys_file.go:650 +0x24a 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 364 (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 357 (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 ================== W0302 01:26:54.988272 50227 error.go:48] FATAL ERROR: waiting on pid 21: waiting on PID 21 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 21: waiting on PID 21 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0": urpc method "containerManager.WaitPID" failed: EOF W0302 01:26:54.989051 50227 main.go:338] Failure to execute command, err: 1 W0302 01:26:54.995910 47664 sandbox.go:742] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-0" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D0302 01:26:54.998222 47664 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.999132 47664 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.999308 47664 sandbox.go:1058] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-0" by destroying sandbox D0302 01:26:54.999499 47664 sandbox.go:788] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 01:26:54.999672 47664 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 47677 I0302 01:26:55.108856 47664 main.go:329] Exiting with status: 16896