D0229 18:29:56.712078 18205 parameters.go:238] Clock(Monotonic): error: 59 ns, adjusted frequency from 2299773837 Hz to 2299774486 Hz I0229 18:29:56.712265 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:29:56.712467 18205 parameters.go:238] Clock(Realtime): error: 393 ns, adjusted frequency from 2299774010 Hz to 2299775263 Hz D0229 18:29:56.712537 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:29:56.712695 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:56.712630 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952883408449201 monotonicBaseRef:2000427436 monotonicFrequency:2299774486 realtimeReady:1 realtimeBaseCycles:8952883409383427 realtimeBaseRef:1583000996712458259 realtimeFrequency:2299775263} D0229 18:29:56.712831 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:56.713115 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:29:56.713250 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:29:57.712041 18205 parameters.go:238] Clock(Monotonic): error: 774 ns, adjusted frequency from 2299774486 Hz to 2299776492 Hz I0229 18:29:57.712467 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:29:57.712745 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:29:57.712439 18205 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0229 18:29:57.712868 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:57.712931 18205 parameters.go:238] Clock(Realtime): error: 613 ns, adjusted frequency from 2299775263 Hz to 2299775995 Hz D0229 18:29:57.713023 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:57.713135 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952885708149791 monotonicBaseRef:3000395304 monotonicFrequency:2299776492 realtimeReady:1 realtimeBaseCycles:8952885710221127 realtimeBaseRef:1583000997712920233 realtimeFrequency:2299775995} D0229 18:29:57.713424 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 18:29:57.713297 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:29:57.713602 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:29:57.713674 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:29:57.713822 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:57.714219 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:29:57.714332 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:29:57.714380 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:57.714742 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:29:57.714989 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:29:58.712116 18205 parameters.go:238] Clock(Monotonic): error: -698 ns, adjusted frequency from 2299776492 Hz to 2299772874 Hz D0229 18:29:58.712348 18205 parameters.go:238] Clock(Realtime): error: -412 ns, adjusted frequency from 2299775995 Hz to 2299773367 Hz I0229 18:29:58.712396 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:29:58.712434 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952888008007486 monotonicBaseRef:4000430613 monotonicFrequency:2299772874 realtimeReady:1 realtimeBaseCycles:8952888008666139 realtimeBaseRef:1583000998712341488 realtimeFrequency:2299773367} D0229 18:29:58.712594 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:29:58.712758 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:58.712842 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:58.713231 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:29:58.713437 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:29:58.937190 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:29:58.937513 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:29:58.937705 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:58.937898 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:29:58.938503 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:29:58.938741 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:29:59.712034 18205 parameters.go:238] Clock(Monotonic): error: 141 ns, adjusted frequency from 2299772874 Hz to 2299774724 Hz D0229 18:29:59.712281 18205 parameters.go:238] Clock(Realtime): error: 126 ns, adjusted frequency from 2299773367 Hz to 2299774652 Hz D0229 18:29:59.712439 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952890307686777 monotonicBaseRef:5000389920 monotonicFrequency:2299774724 realtimeReady:1 realtimeBaseCycles:8952890308277233 realtimeBaseRef:1583000999712270927 realtimeFrequency:2299774652} D0229 18:30:00.712079 18205 parameters.go:238] Clock(Monotonic): error: -41 ns, adjusted frequency from 2299774724 Hz to 2299774358 Hz D0229 18:30:00.712348 18205 parameters.go:238] Clock(Realtime): error: 360 ns, adjusted frequency from 2299774652 Hz to 2299775218 Hz D0229 18:30:00.712521 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952892607549529 monotonicBaseRef:6000428196 monotonicFrequency:2299774358 realtimeReady:1 realtimeBaseCycles:8952892608215721 realtimeBaseRef:1583001000712342167 realtimeFrequency:2299775218} D0229 18:30:01.711925 18205 parameters.go:238] Clock(Monotonic): error: 476 ns, adjusted frequency from 2299774358 Hz to 2299775612 Hz I0229 18:30:01.712057 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:01.712169 18205 parameters.go:238] Clock(Realtime): error: -103 ns, adjusted frequency from 2299775218 Hz to 2299774206 Hz D0229 18:30:01.712294 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:01.712373 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952894906990486 monotonicBaseRef:7000283224 monotonicFrequency:2299775612 realtimeReady:1 realtimeBaseCycles:8952894907576133 realtimeBaseRef:1583001001712161798 realtimeFrequency:2299774206} D0229 18:30:01.712472 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:01.712610 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:01.712896 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:01.713081 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:02.711993 18205 parameters.go:238] Clock(Monotonic): error: -495 ns, adjusted frequency from 2299775612 Hz to 2299773381 Hz D0229 18:30:02.712199 18205 parameters.go:238] Clock(Realtime): error: 205 ns, adjusted frequency from 2299774206 Hz to 2299774952 Hz I0229 18:30:02.712247 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:02.712329 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952897206869946 monotonicBaseRef:8000328379 monotonicFrequency:2299773381 realtimeReady:1 realtimeBaseCycles:8952897207422554 realtimeBaseRef:1583001002712193198 realtimeFrequency:2299774952} D0229 18:30:02.712520 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:02.712859 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:02.713005 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:02.713140 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:02.713310 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:02.713453 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:02.713420 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:02.713594 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:02.713949 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:02.714004 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:02.714120 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:02.714301 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:02.714487 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 18:30:02.936017 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:02.936322 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:02.936518 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:02.936658 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:02.936634 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:02.936788 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:02.936888 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:02.937049 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:03.711954 18205 parameters.go:238] Clock(Monotonic): error: 191 ns, adjusted frequency from 2299773381 Hz to 2299774882 Hz I0229 18:30:03.712110 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:03.712259 18205 parameters.go:238] Clock(Realtime): error: -252 ns, adjusted frequency from 2299774952 Hz to 2299773891 Hz D0229 18:30:03.712388 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:03.712390 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952899506600504 monotonicBaseRef:9000309758 monotonicFrequency:2299774882 realtimeReady:1 realtimeBaseCycles:8952899507322150 realtimeBaseRef:1583001003712247396 realtimeFrequency:2299773891} D0229 18:30:03.712583 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:03.712695 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:03.712941 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:03.713061 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:03.935731 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:03.936071 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:03.936247 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:03.936422 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:03.936510 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:03.936647 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:03.936758 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:03.936924 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:04.712047 18205 parameters.go:238] Clock(Monotonic): error: -207 ns, adjusted frequency from 2299774882 Hz to 2299774121 Hz D0229 18:30:04.712281 18205 parameters.go:238] Clock(Realtime): error: 205 ns, adjusted frequency from 2299773891 Hz to 2299775020 Hz D0229 18:30:04.712387 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952901806583605 monotonicBaseRef:10000400296 monotonicFrequency:2299774121 realtimeReady:1 realtimeBaseCycles:8952901807160548 realtimeBaseRef:1583001004712275445 realtimeFrequency:2299775020} D0229 18:30:05.712115 18205 parameters.go:238] Clock(Monotonic): error: 104 ns, adjusted frequency from 2299774121 Hz to 2299774820 Hz I0229 18:30:05.712303 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:05.712426 18205 parameters.go:238] Clock(Realtime): error: 264 ns, adjusted frequency from 2299775020 Hz to 2299775117 Hz D0229 18:30:05.712600 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:05.712785 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:05.712708 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952904106327611 monotonicBaseRef:11000387201 monotonicFrequency:2299774820 realtimeReady:1 realtimeBaseCycles:8952904107255124 realtimeBaseRef:1583001005712414395 realtimeFrequency:2299775117} D0229 18:30:05.712931 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:05.713082 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:05.713229 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:05.713264 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:05.713364 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:05.713404 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:05.713910 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:05.713996 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:05.714065 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:05.714249 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:05.714397 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:06.712109 18205 parameters.go:238] Clock(Monotonic): error: -80 ns, adjusted frequency from 2299774820 Hz to 2299774282 Hz D0229 18:30:06.712304 18205 parameters.go:238] Clock(Realtime): error: -182 ns, adjusted frequency from 2299775117 Hz to 2299774128 Hz D0229 18:30:06.712467 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952906406294758 monotonicBaseRef:12000470829 monotonicFrequency:2299774282 realtimeReady:1 realtimeBaseCycles:8952906406759773 realtimeBaseRef:1583001006712296788 realtimeFrequency:2299774128} D0229 18:30:07.712643 18205 parameters.go:238] Clock(Monotonic): error: 476 ns, adjusted frequency from 2299774282 Hz to 2299775597 Hz D0229 18:30:07.712896 18205 parameters.go:238] Clock(Realtime): error: 14 ns, adjusted frequency from 2299774128 Hz to 2299774666 Hz D0229 18:30:07.713193 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952908707285559 monotonicBaseRef:13000999802 monotonicFrequency:2299775597 realtimeReady:1 realtimeBaseCycles:8952908707900728 realtimeBaseRef:1583001007712891118 realtimeFrequency:2299774666} D0229 18:30:08.711863 18205 parameters.go:238] Clock(Monotonic): error: -378 ns, adjusted frequency from 2299775597 Hz to 2299773744 Hz D0229 18:30:08.712122 18205 parameters.go:238] Clock(Realtime): error: -115 ns, adjusted frequency from 2299774666 Hz to 2299774296 Hz I0229 18:30:08.712107 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:08.712330 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:08.712266 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952911005208720 monotonicBaseRef:14000194316 monotonicFrequency:2299773744 realtimeReady:1 realtimeBaseCycles:8952911005893618 realtimeBaseRef:1583001008712116356 realtimeFrequency:2299774296} D0229 18:30:08.712455 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:08.712649 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:08.712543 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:08.712764 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:08.712970 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:08.713087 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:09.712318 18205 parameters.go:238] Clock(Monotonic): error: 685 ns, adjusted frequency from 2299773744 Hz to 2299776129 Hz D0229 18:30:09.712600 18205 parameters.go:238] Clock(Realtime): error: -70 ns, adjusted frequency from 2299774296 Hz to 2299774430 Hz D0229 18:30:09.712738 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952913306086831 monotonicBaseRef:15000674522 monotonicFrequency:2299776129 realtimeReady:1 realtimeBaseCycles:8952913306765295 realtimeBaseRef:1583001009712593524 realtimeFrequency:2299774430} D0229 18:30:10.712021 18205 parameters.go:238] Clock(Monotonic): error: -487 ns, adjusted frequency from 2299776129 Hz to 2299773455 Hz I0229 18:30:10.712291 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:10.712409 18205 parameters.go:238] Clock(Realtime): error: 154 ns, adjusted frequency from 2299774430 Hz to 2299775005 Hz D0229 18:30:10.712567 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:10.712563 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952915605055578 monotonicBaseRef:16000323452 monotonicFrequency:2299773455 realtimeReady:1 realtimeBaseCycles:8952915606089359 realtimeBaseRef:1583001010712397693 realtimeFrequency:2299775005} D0229 18:30:10.712674 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:10.712732 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:10.713103 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:10.713327 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:10.935854 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:10.936198 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:10.936403 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:10.936485 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:10.936584 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:10.936750 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:10.936687 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:10.936862 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:10.936886 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:10.937463 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:10.937506 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:10.937560 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:10.937735 18205 task_signals.go:176] [ 2] Not restarting syscall 270 after errno 514: interrupted by signal 23 D0229 18:30:10.937851 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:11.712216 18205 parameters.go:238] Clock(Monotonic): error: -178 ns, adjusted frequency from 2299773455 Hz to 2299774154 Hz I0229 18:30:11.712341 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:11.712472 18205 parameters.go:238] Clock(Realtime): error: -70 ns, adjusted frequency from 2299775005 Hz to 2299774379 Hz D0229 18:30:11.712635 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:11.712622 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952917905379607 monotonicBaseRef:17000562855 monotonicFrequency:2299774154 realtimeReady:1 realtimeBaseCycles:8952917906019399 realtimeBaseRef:1583001011712465106 realtimeFrequency:2299774379} D0229 18:30:11.712795 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:11.713006 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:11.712978 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:11.713137 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:11.713391 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:11.713557 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:12.711817 18205 parameters.go:238] Clock(Monotonic): error: 280 ns, adjusted frequency from 2299774154 Hz to 2299775192 Hz D0229 18:30:12.712075 18205 parameters.go:238] Clock(Realtime): error: -323 ns, adjusted frequency from 2299774379 Hz to 2299773877 Hz D0229 18:30:12.712205 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952920204264582 monotonicBaseRef:18000176217 monotonicFrequency:2299775192 realtimeReady:1 realtimeBaseCycles:8952920204880425 realtimeBaseRef:1583001012712067957 realtimeFrequency:2299773877} I0229 18:30:12.935991 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:12.936242 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:12.936377 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:12.936440 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:12.936527 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:12.936669 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:12.936932 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:12.937036 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:12.937123 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:12.937477 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:12.937645 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:12.937609 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:12.937982 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:12.938113 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:13.712095 18205 parameters.go:238] Clock(Monotonic): error: -88 ns, adjusted frequency from 2299775192 Hz to 2299774382 Hz D0229 18:30:13.712379 18205 parameters.go:238] Clock(Realtime): error: 481 ns, adjusted frequency from 2299773877 Hz to 2299775612 Hz D0229 18:30:13.712549 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952922504674721 monotonicBaseRef:19000452307 monotonicFrequency:2299774382 realtimeReady:1 realtimeBaseCycles:8952922505348870 realtimeBaseRef:1583001013712369972 realtimeFrequency:2299775612} D0229 18:30:14.711965 18205 parameters.go:238] Clock(Monotonic): error: 409 ns, adjusted frequency from 2299774382 Hz to 2299775449 Hz D0229 18:30:14.712225 18205 parameters.go:238] Clock(Realtime): error: -170 ns, adjusted frequency from 2299775612 Hz to 2299774207 Hz I0229 18:30:14.712111 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:14.712328 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952924804147107 monotonicBaseRef:20000320991 monotonicFrequency:2299775449 realtimeReady:1 realtimeBaseCycles:8952924804778071 realtimeBaseRef:1583001014712219343 realtimeFrequency:2299774207} D0229 18:30:14.712412 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:14.712645 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:14.712663 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:14.712845 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:14.712967 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:14.712955 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:14.713291 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:14.713063 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:14.713980 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:14.714045 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:14.714187 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:14.714503 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:14.714662 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:15.711929 18205 parameters.go:238] Clock(Monotonic): error: -557 ns, adjusted frequency from 2299775449 Hz to 2299773310 Hz D0229 18:30:15.712225 18205 parameters.go:238] Clock(Realtime): error: 115 ns, adjusted frequency from 2299774207 Hz to 2299774742 Hz D0229 18:30:15.712349 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952927103827737 monotonicBaseRef:21000279761 monotonicFrequency:2299773310 realtimeReady:1 realtimeBaseCycles:8952927104551543 realtimeBaseRef:1583001015712219023 realtimeFrequency:2299774742} I0229 18:30:15.963821 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:15.964128 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:15.964251 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:15.964349 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:15.964552 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:15.964811 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:16.711920 18205 parameters.go:238] Clock(Monotonic): error: -71 ns, adjusted frequency from 2299773310 Hz to 2299774473 Hz I0229 18:30:16.712034 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:16.712179 18205 parameters.go:238] Clock(Realtime): error: -183 ns, adjusted frequency from 2299774742 Hz to 2299774099 Hz D0229 18:30:16.712276 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:16.712406 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:16.712351 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952929403502367 monotonicBaseRef:22000236852 monotonicFrequency:2299774473 realtimeReady:1 realtimeBaseCycles:8952929404205386 realtimeBaseRef:1583001016712166453 realtimeFrequency:2299774099} I0229 18:30:16.712572 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:16.712728 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:16.712544 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:16.713046 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:16.713187 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:17.711984 18205 parameters.go:238] Clock(Monotonic): error: 431 ns, adjusted frequency from 2299774473 Hz to 2299775500 Hz I0229 18:30:17.712083 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:17.712248 18205 parameters.go:238] Clock(Realtime): error: 459 ns, adjusted frequency from 2299774099 Hz to 2299775688 Hz D0229 18:30:17.712436 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:17.712594 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:17.712415 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952931703497579 monotonicBaseRef:23000332834 monotonicFrequency:2299775500 realtimeReady:1 realtimeBaseCycles:8952931704146983 realtimeBaseRef:1583001017712239285 realtimeFrequency:2299775688} D0229 18:30:17.712727 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:17.713026 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:17.713167 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:17.935978 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:17.936305 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:17.936545 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:17.936668 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:17.936756 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:17.936914 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:17.936879 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:17.937045 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:17.937188 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:17.937757 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:17.937895 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:17.937818 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:17.938110 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:17.938314 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:18.711920 18205 parameters.go:238] Clock(Monotonic): error: 83 ns, adjusted frequency from 2299775500 Hz to 2299774766 Hz D0229 18:30:18.712219 18205 parameters.go:238] Clock(Realtime): error: -243 ns, adjusted frequency from 2299775688 Hz to 2299774028 Hz D0229 18:30:18.712357 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952934003145698 monotonicBaseRef:24000277445 monotonicFrequency:2299774766 realtimeReady:1 realtimeBaseCycles:8952934003860806 realtimeBaseRef:1583001018712212384 realtimeFrequency:2299774028} D0229 18:30:19.711961 18205 parameters.go:238] Clock(Monotonic): error: -434 ns, adjusted frequency from 2299774766 Hz to 2299773574 Hz D0229 18:30:19.712241 18205 parameters.go:238] Clock(Realtime): error: 106 ns, adjusted frequency from 2299774028 Hz to 2299774723 Hz D0229 18:30:19.712390 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952936303013525 monotonicBaseRef:25000317910 monotonicFrequency:2299773574 realtimeReady:1 realtimeBaseCycles:8952936303684132 realtimeBaseRef:1583001019712233820 realtimeFrequency:2299774723} I0229 18:30:19.712467 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:19.712778 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:19.712938 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:19.713042 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:19.713072 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:19.713370 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:19.713414 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:19.713487 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:19.713560 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:19.714009 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:19.714151 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:19.714154 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:19.714466 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:19.714620 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:20.711942 18205 parameters.go:238] Clock(Monotonic): error: 386 ns, adjusted frequency from 2299773574 Hz to 2299775408 Hz I0229 18:30:20.712055 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:20.712175 18205 parameters.go:238] Clock(Realtime): error: -143 ns, adjusted frequency from 2299774723 Hz to 2299774278 Hz D0229 18:30:20.712229 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:20.712497 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:20.712328 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952938602591082 monotonicBaseRef:26000232676 monotonicFrequency:2299775408 realtimeReady:1 realtimeBaseCycles:8952938603308446 realtimeBaseRef:1583001020712168418 realtimeFrequency:2299774278} D0229 18:30:20.712353 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:20.713319 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:20.713454 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:21.711954 18205 parameters.go:238] Clock(Monotonic): error: -294 ns, adjusted frequency from 2299775408 Hz to 2299774008 Hz D0229 18:30:21.712252 18205 parameters.go:238] Clock(Realtime): error: 138 ns, adjusted frequency from 2299774278 Hz to 2299774867 Hz D0229 18:30:21.712439 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952940902525591 monotonicBaseRef:27000301857 monotonicFrequency:2299774008 realtimeReady:1 realtimeBaseCycles:8952940903254353 realtimeBaseRef:1583001021712243046 realtimeFrequency:2299774867} D0229 18:30:22.711928 18205 parameters.go:238] Clock(Monotonic): error: 569 ns, adjusted frequency from 2299774008 Hz to 2299775832 Hz D0229 18:30:22.712220 18205 parameters.go:238] Clock(Realtime): error: 193 ns, adjusted frequency from 2299774867 Hz to 2299775097 Hz D0229 18:30:22.712374 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952943202255919 monotonicBaseRef:28000282863 monotonicFrequency:2299775832 realtimeReady:1 realtimeBaseCycles:8952943202955456 realtimeBaseRef:1583001022712210971 realtimeFrequency:2299775097} I0229 18:30:22.935808 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:22.936162 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:22.936337 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:22.936491 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:22.936973 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:22.937161 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:23.711962 18205 parameters.go:238] Clock(Monotonic): error: -460 ns, adjusted frequency from 2299775832 Hz to 2299773425 Hz I0229 18:30:23.712109 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:23.712202 18205 parameters.go:238] Clock(Realtime): error: -438 ns, adjusted frequency from 2299775097 Hz to 2299773569 Hz D0229 18:30:23.712341 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:23.712318 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952945502067855 monotonicBaseRef:29000298561 monotonicFrequency:2299773425 realtimeReady:1 realtimeBaseCycles:8952945502696398 realtimeBaseRef:1583001023712196119 realtimeFrequency:2299773569} D0229 18:30:23.712488 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:23.712551 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:23.712863 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:23.712973 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:24.712033 18205 parameters.go:238] Clock(Monotonic): error: 0 ns, adjusted frequency from 2299773425 Hz to 2299774554 Hz D0229 18:30:24.712360 18205 parameters.go:238] Clock(Realtime): error: -1 ns, adjusted frequency from 2299773569 Hz to 2299774586 Hz D0229 18:30:24.712533 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952947802000228 monotonicBaseRef:30000367675 monotonicFrequency:2299774554 realtimeReady:1 realtimeBaseCycles:8952947802805138 realtimeBaseRef:1583001024712341859 realtimeFrequency:2299774586} I0229 18:30:24.935795 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:24.936056 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:24.936265 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:24.936379 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:24.936646 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:24.936776 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:25.712176 18205 parameters.go:238] Clock(Monotonic): error: -196 ns, adjusted frequency from 2299774554 Hz to 2299774109 Hz D0229 18:30:25.712484 18205 parameters.go:238] Clock(Realtime): error: 209 ns, adjusted frequency from 2299774586 Hz to 2299774997 Hz D0229 18:30:25.712685 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952950102152986 monotonicBaseRef:31000532127 monotonicFrequency:2299774109 realtimeReady:1 realtimeBaseCycles:8952950102887380 realtimeBaseRef:1583001025712475635 realtimeFrequency:2299774997} I0229 18:30:25.935814 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:25.936084 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:25.936292 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:25.936421 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:25.936463 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:25.936711 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:25.936694 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:25.936831 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:25.936855 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:25.937382 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:25.937425 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:25.937542 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:25.937782 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:25.937963 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 18:30:25.939292 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:25.939849 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:25.941083 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:25.941229 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:25.941323 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:25.941446 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:25.941570 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:25.941734 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:26.711960 18205 parameters.go:238] Clock(Monotonic): error: 136 ns, adjusted frequency from 2299774109 Hz to 2299774966 Hz D0229 18:30:26.712312 18205 parameters.go:238] Clock(Realtime): error: 73 ns, adjusted frequency from 2299774997 Hz to 2299774734 Hz D0229 18:30:26.712469 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952952401417583 monotonicBaseRef:32000310578 monotonicFrequency:2299774966 realtimeReady:1 realtimeBaseCycles:8952952402268971 realtimeBaseRef:1583001026712304572 realtimeFrequency:2299774734} I0229 18:30:26.935889 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:26.936182 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:26.936369 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:26.936498 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:26.936725 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:26.936837 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:27.063641 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:27.063944 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:27.064113 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:27.064129 18205 urpc.go:577] urpc: unmarshal success. D0229 18:30:27.064198 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:27.064405 18205 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 18:30:27.064486 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:27.064606 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:27.064738 18205 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 18:30:27.711895 18205 parameters.go:238] Clock(Monotonic): error: 185 ns, adjusted frequency from 2299774966 Hz to 2299774950 Hz I0229 18:30:27.711974 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:27.712134 18205 parameters.go:238] Clock(Realtime): error: -281 ns, adjusted frequency from 2299774734 Hz to 2299773910 Hz D0229 18:30:27.712271 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:27.712253 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952954700991069 monotonicBaseRef:33000222969 monotonicFrequency:2299774950 realtimeReady:1 realtimeBaseCycles:8952954701638582 realtimeBaseRef:1583001027712128414 realtimeFrequency:2299773910} D0229 18:30:27.712394 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:27.712447 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:27.712528 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:27.712683 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:27.712882 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:27.713053 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:28.711874 18205 parameters.go:238] Clock(Monotonic): error: 39 ns, adjusted frequency from 2299774950 Hz to 2299774681 Hz D0229 18:30:28.712092 18205 parameters.go:238] Clock(Realtime): error: 289 ns, adjusted frequency from 2299773910 Hz to 2299775223 Hz D0229 18:30:28.712467 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952957000786074 monotonicBaseRef:34000231689 monotonicFrequency:2299774681 realtimeReady:1 realtimeBaseCycles:8952957001312099 realtimeBaseRef:1583001028712084760 realtimeFrequency:2299775223} I0229 18:30:28.935865 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:28.936119 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:28.936292 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:28.936387 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:28.936613 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 18:30:28.936524 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:28.936976 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:28.936792 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:28.937082 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:28.937711 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:28.937830 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:28.937809 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:28.937997 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:28.938134 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:29.711943 18205 parameters.go:238] Clock(Monotonic): error: -256 ns, adjusted frequency from 2299774681 Hz to 2299774053 Hz D0229 18:30:29.712229 18205 parameters.go:238] Clock(Realtime): error: -270 ns, adjusted frequency from 2299775223 Hz to 2299773978 Hz D0229 18:30:29.712447 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952959300725387 monotonicBaseRef:35000303275 monotonicFrequency:2299774053 realtimeReady:1 realtimeBaseCycles:8952959301398453 realtimeBaseRef:1583001029712220047 realtimeFrequency:2299773978} D0229 18:30:30.711868 18205 parameters.go:238] Clock(Monotonic): error: -157 ns, adjusted frequency from 2299774053 Hz to 2299774196 Hz D0229 18:30:30.712079 18205 parameters.go:238] Clock(Realtime): error: 40 ns, adjusted frequency from 2299773978 Hz to 2299774666 Hz D0229 18:30:30.712224 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952961600296939 monotonicBaseRef:36000215222 monotonicFrequency:2299774196 realtimeReady:1 realtimeBaseCycles:8952961600811348 realtimeBaseRef:1583001030712063038 realtimeFrequency:2299774666} I0229 18:30:30.712726 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:30.713089 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:30.713303 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:30.713422 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:30.713831 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:30.714022 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:31.711919 18205 parameters.go:238] Clock(Monotonic): error: 141 ns, adjusted frequency from 2299774196 Hz to 2299774957 Hz D0229 18:30:31.712154 18205 parameters.go:238] Clock(Realtime): error: 236 ns, adjusted frequency from 2299774666 Hz to 2299775035 Hz D0229 18:30:31.712328 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952963900215589 monotonicBaseRef:37000278034 monotonicFrequency:2299774957 realtimeReady:1 realtimeBaseCycles:8952963900779138 realtimeBaseRef:1583001031712147013 realtimeFrequency:2299775035} D0229 18:30:32.711939 18205 parameters.go:238] Clock(Monotonic): error: -49 ns, adjusted frequency from 2299774957 Hz to 2299774612 Hz I0229 18:30:32.712054 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:32.712127 18205 parameters.go:238] Clock(Realtime): error: 140 ns, adjusted frequency from 2299775035 Hz to 2299774909 Hz D0229 18:30:32.712382 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:32.712517 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:32.712575 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:32.712708 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:32.712481 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952966199966710 monotonicBaseRef:38000267669 monotonicFrequency:2299774612 realtimeReady:1 realtimeBaseCycles:8952966200463494 realtimeBaseRef:1583001032712107583 realtimeFrequency:2299774909} D0229 18:30:32.712851 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:32.712882 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:32.712997 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:32.713063 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:32.713478 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:32.713526 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:32.713578 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:32.713764 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:32.713909 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:33.711816 18205 parameters.go:238] Clock(Monotonic): error: -72 ns, adjusted frequency from 2299774612 Hz to 2299774424 Hz D0229 18:30:33.712027 18205 parameters.go:238] Clock(Realtime): error: -412 ns, adjusted frequency from 2299774909 Hz to 2299773632 Hz I0229 18:30:33.712280 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:33.712266 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952968499534536 monotonicBaseRef:39000177753 monotonicFrequency:2299774424 realtimeReady:1 realtimeBaseCycles:8952968500030331 realtimeBaseRef:1583001033712017108 realtimeFrequency:2299773632} D0229 18:30:33.712548 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:33.712734 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:33.712925 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:33.712951 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:33.713044 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:33.713871 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:33.714063 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:34.711903 18205 parameters.go:238] Clock(Monotonic): error: 190 ns, adjusted frequency from 2299774424 Hz to 2299774900 Hz D0229 18:30:34.712125 18205 parameters.go:238] Clock(Realtime): error: -55 ns, adjusted frequency from 2299773632 Hz to 2299774567 Hz D0229 18:30:34.712292 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952970799467337 monotonicBaseRef:40000246619 monotonicFrequency:2299774900 realtimeReady:1 realtimeBaseCycles:8952970800010666 realtimeBaseRef:1583001034712106987 realtimeFrequency:2299774567} I0229 18:30:34.935687 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:34.936026 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:34.936187 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:34.936247 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:34.936455 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 18:30:34.936440 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:34.936596 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:34.936695 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:34.936805 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:34.937039 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:34.937155 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:34.937174 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:34.937425 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:34.937624 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:35.712768 18205 parameters.go:238] Clock(Monotonic): error: 65 ns, adjusted frequency from 2299774900 Hz to 2299774704 Hz I0229 18:30:35.713116 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:35.713167 18205 parameters.go:238] Clock(Realtime): error: 267 ns, adjusted frequency from 2299774567 Hz to 2299775131 Hz D0229 18:30:35.713328 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:35.713317 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952973101267810 monotonicBaseRef:41001127389 monotonicFrequency:2299774704 realtimeReady:1 realtimeBaseCycles:8952973102194357 realtimeBaseRef:1583001035713154534 realtimeFrequency:2299775131} D0229 18:30:35.713479 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:35.713565 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:35.713657 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:35.713825 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:35.714077 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:35.714238 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:35.964088 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:35.964344 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:35.964515 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:35.964578 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:35.964756 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:35.964863 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:36.712217 18205 parameters.go:238] Clock(Monotonic): error: 210 ns, adjusted frequency from 2299774704 Hz to 2299775089 Hz D0229 18:30:36.712444 18205 parameters.go:238] Clock(Realtime): error: -112 ns, adjusted frequency from 2299775131 Hz to 2299774400 Hz D0229 18:30:36.712637 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952975399772294 monotonicBaseRef:42000575065 monotonicFrequency:2299775089 realtimeReady:1 realtimeBaseCycles:8952975400315020 realtimeBaseRef:1583001036712435129 realtimeFrequency:2299774400} D0229 18:30:37.711952 18205 parameters.go:238] Clock(Monotonic): error: -318 ns, adjusted frequency from 2299775089 Hz to 2299773823 Hz D0229 18:30:37.712176 18205 parameters.go:238] Clock(Realtime): error: 21 ns, adjusted frequency from 2299774400 Hz to 2299774591 Hz D0229 18:30:37.712376 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952977698937519 monotonicBaseRef:43000309880 monotonicFrequency:2299773823 realtimeReady:1 realtimeBaseCycles:8952977699474781 realtimeBaseRef:1583001037712167868 realtimeFrequency:2299774591} D0229 18:30:38.712332 18205 parameters.go:238] Clock(Monotonic): error: -212 ns, adjusted frequency from 2299773823 Hz to 2299774070 Hz D0229 18:30:38.712560 18205 parameters.go:238] Clock(Realtime): error: 21 ns, adjusted frequency from 2299774591 Hz to 2299774575 Hz D0229 18:30:38.712748 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952979999599429 monotonicBaseRef:44000696042 monotonicFrequency:2299774070 realtimeReady:1 realtimeBaseCycles:8952980000135415 realtimeBaseRef:1583001038712553141 realtimeFrequency:2299774575} I0229 18:30:38.935932 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:38.936180 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:38.936336 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:38.936506 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:38.936797 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:38.936919 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:39.712046 18205 parameters.go:238] Clock(Monotonic): error: 200 ns, adjusted frequency from 2299774070 Hz to 2299775056 Hz I0229 18:30:39.712098 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:39.712349 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:39.712304 18205 parameters.go:238] Clock(Realtime): error: -192 ns, adjusted frequency from 2299774575 Hz to 2299774129 Hz D0229 18:30:39.712516 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:39.712553 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:39.712766 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952982298651464 monotonicBaseRef:45000382082 monotonicFrequency:2299775056 realtimeReady:1 realtimeBaseCycles:8952982299312778 realtimeBaseRef:1583001039712293458 realtimeFrequency:2299774129} I0229 18:30:39.713010 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:39.713087 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:39.713236 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:39.713256 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:39.713406 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:39.713831 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:39.713877 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:39.713974 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:39.714169 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:39.714290 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 18:30:39.911673 18205 watchdog.go:277] Watchdog starting loop, tasks: 17, discount: 0s D0229 18:30:40.711966 18205 parameters.go:238] Clock(Monotonic): error: -54 ns, adjusted frequency from 2299775056 Hz to 2299774440 Hz I0229 18:30:40.712071 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:40.712188 18205 parameters.go:238] Clock(Realtime): error: 147 ns, adjusted frequency from 2299774129 Hz to 2299774979 Hz D0229 18:30:40.712344 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:40.712411 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952984598242415 monotonicBaseRef:46000302028 monotonicFrequency:2299774440 realtimeReady:1 realtimeBaseCycles:8952984598823145 realtimeBaseRef:1583001040712178767 realtimeFrequency:2299774979} D0229 18:30:40.712558 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:40.712621 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:40.712923 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:40.713087 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:41.711866 18205 parameters.go:238] Clock(Monotonic): error: 397 ns, adjusted frequency from 2299774440 Hz to 2299775426 Hz D0229 18:30:41.712107 18205 parameters.go:238] Clock(Realtime): error: -71 ns, adjusted frequency from 2299774979 Hz to 2299774355 Hz I0229 18:30:41.712080 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:41.712303 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952986897839596 monotonicBaseRef:47000224951 monotonicFrequency:2299775426 realtimeReady:1 realtimeBaseCycles:8952986898405853 realtimeBaseRef:1583001041712095162 realtimeFrequency:2299774355} D0229 18:30:41.712512 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:41.712658 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:41.712691 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:41.712843 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:41.712964 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:41.713044 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:41.713087 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:41.713206 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:41.713609 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:41.713710 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:41.713752 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:41.714145 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:41.714332 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:42.711984 18205 parameters.go:238] Clock(Monotonic): error: 81 ns, adjusted frequency from 2299775426 Hz to 2299774680 Hz I0229 18:30:42.712208 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:42.712289 18205 parameters.go:238] Clock(Realtime): error: -188 ns, adjusted frequency from 2299774355 Hz to 2299774170 Hz D0229 18:30:42.712430 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:42.712429 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952989197889032 monotonicBaseRef:48000344097 monotonicFrequency:2299774680 realtimeReady:1 realtimeBaseCycles:8952989198597459 realtimeBaseRef:1583001042712276593 realtimeFrequency:2299774170} D0229 18:30:42.712610 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:42.712686 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:42.712844 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:42.713065 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:42.713059 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:42.713145 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:42.713250 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:42.713907 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:42.714030 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:42.714037 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:42.714209 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:42.714346 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:43.712286 18205 parameters.go:238] Clock(Monotonic): error: -612 ns, adjusted frequency from 2299774680 Hz to 2299773288 Hz D0229 18:30:43.712452 18205 parameters.go:238] Clock(Realtime): error: 135 ns, adjusted frequency from 2299774170 Hz to 2299774801 Hz D0229 18:30:43.712580 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952991498357371 monotonicBaseRef:49000645717 monotonicFrequency:2299773288 realtimeReady:1 realtimeBaseCycles:8952991498764105 realtimeBaseRef:1583001043712447251 realtimeFrequency:2299774801} I0229 18:30:43.936426 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:43.936650 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:43.936799 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:43.936854 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:43.936979 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:43.937166 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:43.937180 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:43.937337 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:43.937481 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:43.938000 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:43.938110 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:43.938189 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:43.938350 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:43.938563 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:44.712108 18205 parameters.go:238] Clock(Monotonic): error: 215 ns, adjusted frequency from 2299773288 Hz to 2299775074 Hz D0229 18:30:44.712306 18205 parameters.go:238] Clock(Realtime): error: 143 ns, adjusted frequency from 2299774801 Hz to 2299774936 Hz I0229 18:30:44.712273 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:44.712502 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952993797718655 monotonicBaseRef:50000466567 monotonicFrequency:2299775074 realtimeReady:1 realtimeBaseCycles:8952993798199641 realtimeBaseRef:1583001044712299730 realtimeFrequency:2299774936} D0229 18:30:44.712566 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:44.712716 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:44.712816 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:44.712909 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:44.713103 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:44.713094 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:44.713214 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:44.713279 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:44.713804 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:44.713780 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:44.713978 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:44.714150 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:44.714334 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:45.711930 18205 parameters.go:238] Clock(Monotonic): error: 147 ns, adjusted frequency from 2299775074 Hz to 2299774868 Hz I0229 18:30:45.712076 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:45.712163 18205 parameters.go:238] Clock(Realtime): error: -22 ns, adjusted frequency from 2299774936 Hz to 2299774435 Hz D0229 18:30:45.712308 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:45.712373 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952996097087877 monotonicBaseRef:51000290092 monotonicFrequency:2299774868 realtimeReady:1 realtimeBaseCycles:8952996097642689 realtimeBaseRef:1583001045712155416 realtimeFrequency:2299774435} D0229 18:30:45.712457 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.712508 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.712764 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:45.712941 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:45.964097 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:45.964418 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:45.964580 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.964627 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:45.964799 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:45.964866 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:45.964931 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:45.965072 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:45.965200 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.965758 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:45.965893 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:45.966016 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.966387 18205 task_signals.go:176] [ 2] Not restarting syscall 270 after errno 514: interrupted by signal 23 D0229 18:30:45.966581 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 18:30:45.967859 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:45.968371 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:45.968719 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.968777 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.970223 18205 task_block.go:223] [ 2] Interrupt queued I0229 18:30:45.970184 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:45.970419 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:45.970491 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:45.970660 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:45.970868 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:45.971078 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:46.711943 18205 parameters.go:238] Clock(Monotonic): error: -226 ns, adjusted frequency from 2299774868 Hz to 2299774054 Hz D0229 18:30:46.712286 18205 parameters.go:238] Clock(Realtime): error: -124 ns, adjusted frequency from 2299774435 Hz to 2299774391 Hz D0229 18:30:46.712515 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8952998396887843 monotonicBaseRef:52000301005 monotonicFrequency:2299774054 realtimeReady:1 realtimeBaseCycles:8952998397696635 realtimeBaseRef:1583001046712276954 realtimeFrequency:2299774391} I0229 18:30:46.935819 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:46.936067 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:46.936246 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:46.936390 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:46.936613 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:46.936797 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:47.711946 18205 parameters.go:238] Clock(Monotonic): error: 1 ns, adjusted frequency from 2299774054 Hz to 2299774594 Hz D0229 18:30:47.712246 18205 parameters.go:238] Clock(Realtime): error: 556 ns, adjusted frequency from 2299774391 Hz to 2299775994 Hz D0229 18:30:47.712462 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953000696653485 monotonicBaseRef:53000297347 monotonicFrequency:2299774594 realtimeReady:1 realtimeBaseCycles:8953000697378337 realtimeBaseRef:1583001047712236650 realtimeFrequency:2299775994} D0229 18:30:48.711946 18205 parameters.go:238] Clock(Monotonic): error: 239 ns, adjusted frequency from 2299774594 Hz to 2299775149 Hz I0229 18:30:48.712148 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:48.712215 18205 parameters.go:238] Clock(Realtime): error: -390 ns, adjusted frequency from 2299775994 Hz to 2299773649 Hz D0229 18:30:48.712380 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:48.712593 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:48.712407 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953002996445383 monotonicBaseRef:54000304871 monotonicFrequency:2299775149 realtimeReady:1 realtimeBaseCycles:8953002997085467 realtimeBaseRef:1583001048712206706 realtimeFrequency:2299773649} D0229 18:30:48.712628 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:48.712905 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:48.713062 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:49.712048 18205 parameters.go:238] Clock(Monotonic): error: -230 ns, adjusted frequency from 2299775149 Hz to 2299774043 Hz D0229 18:30:49.712328 18205 parameters.go:238] Clock(Realtime): error: 45 ns, adjusted frequency from 2299773649 Hz to 2299774656 Hz D0229 18:30:49.712502 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953005296431871 monotonicBaseRef:55000396766 monotonicFrequency:2299774043 realtimeReady:1 realtimeBaseCycles:8953005297108911 realtimeBaseRef:1583001049712315323 realtimeFrequency:2299774656} I0229 18:30:49.935747 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:49.936017 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:49.936234 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:49.936376 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:49.936392 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:49.936588 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:49.936674 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:49.936705 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:49.936828 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:49.937158 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:49.937279 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:49.937275 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:49.937538 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:49.937690 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:50.712092 18205 parameters.go:238] Clock(Monotonic): error: 43 ns, adjusted frequency from 2299774043 Hz to 2299774733 Hz I0229 18:30:50.712257 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:50.712403 18205 parameters.go:238] Clock(Realtime): error: -162 ns, adjusted frequency from 2299774656 Hz to 2299774240 Hz D0229 18:30:50.712465 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:50.712603 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:50.712656 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:50.712542 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953007596304082 monotonicBaseRef:56000439451 monotonicFrequency:2299774733 realtimeReady:1 realtimeBaseCycles:8953007597069916 realtimeBaseRef:1583001050712396352 realtimeFrequency:2299774240} D0229 18:30:50.712946 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:50.713146 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:50.936880 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:50.937126 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:50.937233 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:50.937371 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:50.937516 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:50.937643 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:51.711967 18205 parameters.go:238] Clock(Monotonic): error: -66 ns, adjusted frequency from 2299774733 Hz to 2299774502 Hz D0229 18:30:51.712191 18205 parameters.go:238] Clock(Realtime): error: -159 ns, adjusted frequency from 2299774240 Hz to 2299774218 Hz I0229 18:30:51.712117 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:51.712322 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953009895819352 monotonicBaseRef:57000326629 monotonicFrequency:2299774502 realtimeReady:1 realtimeBaseCycles:8953009896346697 realtimeBaseRef:1583001051712180044 realtimeFrequency:2299774218} D0229 18:30:51.712534 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:51.712876 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:51.713009 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:51.713278 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:51.713383 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:52.712366 18205 parameters.go:238] Clock(Monotonic): error: 121 ns, adjusted frequency from 2299774502 Hz to 2299774746 Hz D0229 18:30:52.712579 18205 parameters.go:238] Clock(Realtime): error: 18 ns, adjusted frequency from 2299774218 Hz to 2299774652 Hz I0229 18:30:52.712576 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:52.712718 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953012196516326 monotonicBaseRef:58000727743 monotonicFrequency:2299774746 realtimeReady:1 realtimeBaseCycles:8953012197027317 realtimeBaseRef:1583001052712574170 realtimeFrequency:2299774652} D0229 18:30:52.712827 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:52.712955 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:52.713050 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:52.713095 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:52.713219 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:52.713370 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:52.713506 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:52.935927 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:52.936230 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:52.936392 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:52.936428 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:52.936669 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:52.936805 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:53.711793 18205 parameters.go:238] Clock(Monotonic): error: -216 ns, adjusted frequency from 2299774746 Hz to 2299774089 Hz I0229 18:30:53.711974 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:53.712069 18205 parameters.go:238] Clock(Realtime): error: 230 ns, adjusted frequency from 2299774652 Hz to 2299775097 Hz D0229 18:30:53.712377 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:53.712486 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953014494887425 monotonicBaseRef:59000117401 monotonicFrequency:2299774089 realtimeReady:1 realtimeBaseCycles:8953014495624105 realtimeBaseRef:1583001053712062005 realtimeFrequency:2299775097} D0229 18:30:53.712600 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:53.712716 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:53.713109 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:53.713265 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:53.714142 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:53.714355 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:53.714508 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:53.714532 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:53.714709 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:53.714821 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:30:53.935847 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:53.936100 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:53.936261 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:53.936431 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:53.936563 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:53.936575 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:53.936783 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:53.936927 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:54.711855 18205 parameters.go:238] Clock(Monotonic): error: 244 ns, adjusted frequency from 2299774089 Hz to 2299775156 Hz D0229 18:30:54.712061 18205 parameters.go:238] Clock(Realtime): error: -174 ns, adjusted frequency from 2299775097 Hz to 2299774177 Hz D0229 18:30:54.712187 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953016794888900 monotonicBaseRef:60000216274 monotonicFrequency:2299775156 realtimeReady:1 realtimeBaseCycles:8953016795383068 realtimeBaseRef:1583001054712054989 realtimeFrequency:2299774177} I0229 18:30:54.935930 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:54.936212 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:54.936336 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:54.936456 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:54.936541 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:54.936725 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:54.936791 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:54.936930 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:54.937070 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:54.937554 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:54.937584 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:30:54.937701 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:54.937973 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:30:54.938133 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:30:55.711909 18205 parameters.go:238] Clock(Monotonic): error: 19 ns, adjusted frequency from 2299775156 Hz to 2299774520 Hz D0229 18:30:55.712103 18205 parameters.go:238] Clock(Realtime): error: 92 ns, adjusted frequency from 2299774177 Hz to 2299774685 Hz I0229 18:30:55.712103 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:55.712240 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953019094784672 monotonicBaseRef:61000268720 monotonicFrequency:2299774520 realtimeReady:1 realtimeBaseCycles:8953019095254939 realtimeBaseRef:1583001055712097468 realtimeFrequency:2299774685} D0229 18:30:55.712383 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:55.712555 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:55.712690 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:55.712715 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:55.712782 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:55.712917 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:55.713011 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:56.711994 18205 parameters.go:238] Clock(Monotonic): error: -37 ns, adjusted frequency from 2299774520 Hz to 2299774480 Hz D0229 18:30:56.712312 18205 parameters.go:238] Clock(Realtime): error: 248 ns, adjusted frequency from 2299774685 Hz to 2299774973 Hz D0229 18:30:56.712511 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953021394715543 monotonicBaseRef:62000336705 monotonicFrequency:2299774480 realtimeReady:1 realtimeBaseCycles:8953021395502916 realtimeBaseRef:1583001056712303267 realtimeFrequency:2299774973} D0229 18:30:57.711974 18205 parameters.go:238] Clock(Monotonic): error: -169 ns, adjusted frequency from 2299774480 Hz to 2299774155 Hz D0229 18:30:57.712266 18205 parameters.go:238] Clock(Realtime): error: -67 ns, adjusted frequency from 2299774973 Hz to 2299774435 Hz D0229 18:30:57.712389 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953023694475129 monotonicBaseRef:63000330228 monotonicFrequency:2299774155 realtimeReady:1 realtimeBaseCycles:8953023695176017 realtimeBaseRef:1583001057712258970 realtimeFrequency:2299774435} I0229 18:30:57.906285 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:57.906533 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:57.906584 18205 urpc.go:577] urpc: unmarshal success. D0229 18:30:57.906704 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:57.906742 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:57.906898 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:57.906892 18205 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 18:30:57.907003 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:57.907277 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:57.907417 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:57.907448 18205 urpc.go:534] urpc: successfully marshalled 37 bytes. I0229 18:30:57.935845 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:57.936056 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:30:57.936252 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:30:57.936408 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:30:57.936435 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:30:57.936585 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:30:57.936739 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:30:57.936893 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:30:58.712869 18205 parameters.go:238] Clock(Monotonic): error: 51 ns, adjusted frequency from 2299774155 Hz to 2299774703 Hz D0229 18:30:58.713112 18205 parameters.go:238] Clock(Realtime): error: 2 ns, adjusted frequency from 2299774435 Hz to 2299774592 Hz D0229 18:30:58.713237 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953025996318552 monotonicBaseRef:64001229998 monotonicFrequency:2299774703 realtimeReady:1 realtimeBaseCycles:8953025996898036 realtimeBaseRef:1583001058713105828 realtimeFrequency:2299774592} D0229 18:30:59.711933 18205 parameters.go:238] Clock(Monotonic): error: 42 ns, adjusted frequency from 2299774703 Hz to 2299774678 Hz D0229 18:30:59.712208 18205 parameters.go:238] Clock(Realtime): error: 159 ns, adjusted frequency from 2299774592 Hz to 2299774912 Hz D0229 18:30:59.712430 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953028293929804 monotonicBaseRef:65000289274 monotonicFrequency:2299774678 realtimeReady:1 realtimeBaseCycles:8953028294580235 realtimeBaseRef:1583001059712196002 realtimeFrequency:2299774912} D0229 18:31:00.712052 18205 parameters.go:238] Clock(Monotonic): error: 55 ns, adjusted frequency from 2299774678 Hz to 2299774708 Hz D0229 18:31:00.712297 18205 parameters.go:238] Clock(Realtime): error: -319 ns, adjusted frequency from 2299774912 Hz to 2299773787 Hz I0229 18:31:00.712342 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:00.712447 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953030593906043 monotonicBaseRef:66000376917 monotonicFrequency:2299774708 realtimeReady:1 realtimeBaseCycles:8953030594564848 realtimeBaseRef:1583001060712287185 realtimeFrequency:2299773787} D0229 18:31:00.712553 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:00.712703 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:00.712721 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:00.712864 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:00.712975 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:00.712952 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:00.713061 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:00.713093 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:00.713704 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:00.713772 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:00.713820 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:00.713960 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:00.714105 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:01.711921 18205 parameters.go:238] Clock(Monotonic): error: -16 ns, adjusted frequency from 2299774708 Hz to 2299774653 Hz I0229 18:31:01.712103 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:01.712277 18205 parameters.go:238] Clock(Realtime): error: -175 ns, adjusted frequency from 2299773787 Hz to 2299774219 Hz D0229 18:31:01.712449 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:01.712612 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:01.712588 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953032893369395 monotonicBaseRef:67000241531 monotonicFrequency:2299774653 realtimeReady:1 realtimeBaseCycles:8953032894297223 realtimeBaseRef:1583001061712269178 realtimeFrequency:2299774219} D0229 18:31:01.712802 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:01.712813 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:01.713080 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:01.713238 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:01.713421 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:01.935757 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:01.935985 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:01.936168 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:01.936266 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:01.936327 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:01.936506 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:01.936528 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:01.936613 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:01.936719 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:01.937203 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:01.937332 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:01.937369 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:01.937642 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:01.937783 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:02.711991 18205 parameters.go:238] Clock(Monotonic): error: -254 ns, adjusted frequency from 2299774653 Hz to 2299773986 Hz D0229 18:31:02.712238 18205 parameters.go:238] Clock(Realtime): error: 14 ns, adjusted frequency from 2299774219 Hz to 2299774662 Hz D0229 18:31:02.712338 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953035193392800 monotonicBaseRef:68000349694 monotonicFrequency:2299773986 realtimeReady:1 realtimeBaseCycles:8953035193979693 realtimeBaseRef:1583001062712229283 realtimeFrequency:2299774662} I0229 18:31:02.712305 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:02.712672 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:02.712816 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:02.712962 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:02.713033 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:02.713129 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:02.713506 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:02.713754 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:03.712042 18205 parameters.go:238] Clock(Monotonic): error: 650 ns, adjusted frequency from 2299773986 Hz to 2299776110 Hz I0229 18:31:03.712217 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:03.712467 18205 parameters.go:238] Clock(Realtime): error: -32 ns, adjusted frequency from 2299774662 Hz to 2299774508 Hz D0229 18:31:03.712635 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:03.712666 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953037493280573 monotonicBaseRef:69000399171 monotonicFrequency:2299776110 realtimeReady:1 realtimeBaseCycles:8953037494259847 realtimeBaseRef:1583001063712449083 realtimeFrequency:2299774508} D0229 18:31:03.712832 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:03.712956 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:03.713191 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:03.713315 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:03.935858 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:03.936219 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:03.936346 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:03.936422 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:03.936497 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:03.936596 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:03.936860 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:03.937103 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:04.711957 18205 parameters.go:238] Clock(Monotonic): error: -688 ns, adjusted frequency from 2299776110 Hz to 2299773061 Hz D0229 18:31:04.712237 18205 parameters.go:238] Clock(Realtime): error: 395 ns, adjusted frequency from 2299774508 Hz to 2299775538 Hz I0229 18:31:04.712263 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:04.712458 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953039792866885 monotonicBaseRef:70000316642 monotonicFrequency:2299773061 realtimeReady:1 realtimeBaseCycles:8953039793529029 realtimeBaseRef:1583001064712229354 realtimeFrequency:2299775538} D0229 18:31:04.712564 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:04.712769 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:04.712853 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:04.713065 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:04.713198 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:04.935861 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:04.936267 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:04.936470 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:04.936499 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:04.936658 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:04.936698 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:04.936830 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:04.936900 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:04.936988 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:04.937373 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:04.937467 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:04.937563 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:04.937761 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:04.937896 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:05.712048 18205 parameters.go:238] Clock(Monotonic): error: 398 ns, adjusted frequency from 2299773061 Hz to 2299775454 Hz D0229 18:31:05.712280 18205 parameters.go:238] Clock(Realtime): error: -234 ns, adjusted frequency from 2299775538 Hz to 2299774086 Hz D0229 18:31:05.712419 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953042092831754 monotonicBaseRef:71000400045 monotonicFrequency:2299775454 realtimeReady:1 realtimeBaseCycles:8953042093407261 realtimeBaseRef:1583001065712274007 realtimeFrequency:2299774086} I0229 18:31:05.963869 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:05.964220 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:05.964432 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:05.964530 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:05.964818 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:05.964918 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:06.712004 18205 parameters.go:238] Clock(Monotonic): error: 429 ns, adjusted frequency from 2299775454 Hz to 2299775579 Hz D0229 18:31:06.712252 18205 parameters.go:238] Clock(Realtime): error: -312 ns, adjusted frequency from 2299774086 Hz to 2299773901 Hz D0229 18:31:06.712443 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953044392506018 monotonicBaseRef:72000356045 monotonicFrequency:2299775579 realtimeReady:1 realtimeBaseCycles:8953044393116279 realtimeBaseRef:1583001066712245713 realtimeFrequency:2299773901} I0229 18:31:06.935788 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:06.936099 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:06.936353 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:06.936517 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:06.936531 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:06.936628 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:06.936764 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:06.936878 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:07.711943 18205 parameters.go:238] Clock(Monotonic): error: -375 ns, adjusted frequency from 2299775579 Hz to 2299773648 Hz I0229 18:31:07.712193 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:07.712247 18205 parameters.go:238] Clock(Realtime): error: 78 ns, adjusted frequency from 2299773901 Hz to 2299774802 Hz D0229 18:31:07.712416 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:07.712470 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953046692154539 monotonicBaseRef:73000300797 monotonicFrequency:2299773648 realtimeReady:1 realtimeBaseCycles:8953046692872142 realtimeBaseRef:1583001067712237869 realtimeFrequency:2299774802} D0229 18:31:07.712543 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:07.712597 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:07.712826 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:07.712968 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:08.712043 18205 parameters.go:238] Clock(Monotonic): error: -297 ns, adjusted frequency from 2299773648 Hz to 2299773895 Hz D0229 18:31:08.712396 18205 parameters.go:238] Clock(Realtime): error: 129 ns, adjusted frequency from 2299774802 Hz to 2299774867 Hz I0229 18:31:08.712353 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:08.712490 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953048992155758 monotonicBaseRef:74000399750 monotonicFrequency:2299773895 realtimeReady:1 realtimeBaseCycles:8953048992997471 realtimeBaseRef:1583001068712390286 realtimeFrequency:2299774867} D0229 18:31:08.712689 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:08.712834 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.712974 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:08.712989 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:08.713282 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:08.713298 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:08.713449 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:08.713514 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.714023 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:08.714165 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:08.714120 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.714982 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:08.715119 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 18:31:08.935786 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:08.936051 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:08.936194 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.936277 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.936542 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:08.936662 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:08.937670 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:08.939611 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:08.939755 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.939845 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:08.940005 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:08.940121 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:08.940093 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:08.940235 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.940282 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:08.940725 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:08.940779 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:08.940871 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:08.941187 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:08.941425 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:09.711921 18205 parameters.go:238] Clock(Monotonic): error: 222 ns, adjusted frequency from 2299773895 Hz to 2299775007 Hz D0229 18:31:09.712185 18205 parameters.go:238] Clock(Realtime): error: -17 ns, adjusted frequency from 2299774867 Hz to 2299774517 Hz D0229 18:31:09.712316 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953051291656226 monotonicBaseRef:75000280857 monotonicFrequency:2299775007 realtimeReady:1 realtimeBaseCycles:8953051292286281 realtimeBaseRef:1583001069712178936 realtimeFrequency:2299774517} D0229 18:31:10.711987 18205 parameters.go:238] Clock(Monotonic): error: -91 ns, adjusted frequency from 2299775007 Hz to 2299774245 Hz I0229 18:31:10.712076 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:10.712346 18205 parameters.go:238] Clock(Realtime): error: 161 ns, adjusted frequency from 2299774517 Hz to 2299774846 Hz D0229 18:31:10.712459 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:10.712525 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953053591539653 monotonicBaseRef:76000328000 monotonicFrequency:2299774245 realtimeReady:1 realtimeBaseCycles:8953053592424351 realtimeBaseRef:1583001070712337018 realtimeFrequency:2299774846} D0229 18:31:10.712632 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:10.712712 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:10.712953 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:10.713004 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:10.713192 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:10.713095 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:10.713404 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:10.713584 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:10.713722 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:10.713607 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:10.713920 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:10.714066 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 18:31:10.935900 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:10.936209 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:10.936342 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:10.936490 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:10.936707 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:10.936850 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:11.711980 18205 parameters.go:238] Clock(Monotonic): error: 12 ns, adjusted frequency from 2299774245 Hz to 2299774618 Hz I0229 18:31:11.712142 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:11.712248 18205 parameters.go:238] Clock(Realtime): error: -175 ns, adjusted frequency from 2299774846 Hz to 2299774186 Hz D0229 18:31:11.712432 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:11.712442 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953055891333940 monotonicBaseRef:77000336714 monotonicFrequency:2299774618 realtimeReady:1 realtimeBaseCycles:8953055891968581 realtimeBaseRef:1583001071712236740 realtimeFrequency:2299774186} D0229 18:31:11.712601 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:11.712667 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:11.712787 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:11.712943 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:11.712953 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:11.713073 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:11.713104 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:11.713530 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:11.713599 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:11.713641 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:11.713971 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:11.714121 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:12.712303 18205 parameters.go:238] Clock(Monotonic): error: 116 ns, adjusted frequency from 2299774618 Hz to 2299774860 Hz D0229 18:31:12.712510 18205 parameters.go:238] Clock(Realtime): error: 141 ns, adjusted frequency from 2299774186 Hz to 2299774899 Hz D0229 18:31:12.712709 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953058191861414 monotonicBaseRef:78000664074 monotonicFrequency:2299774860 realtimeReady:1 realtimeBaseCycles:8953058192359122 realtimeBaseRef:1583001072712504746 realtimeFrequency:2299774899} D0229 18:31:13.711989 18205 parameters.go:238] Clock(Monotonic): error: 436 ns, adjusted frequency from 2299774860 Hz to 2299775681 Hz D0229 18:31:13.712319 18205 parameters.go:238] Clock(Realtime): error: 36 ns, adjusted frequency from 2299774899 Hz to 2299774621 Hz D0229 18:31:13.712513 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953060490896155 monotonicBaseRef:79000342251 monotonicFrequency:2299775681 realtimeReady:1 realtimeBaseCycles:8953060491677080 realtimeBaseRef:1583001073712306056 realtimeFrequency:2299774621} I0229 18:31:13.935909 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:13.936225 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:13.936384 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:13.936575 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:13.936474 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:13.936701 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:13.936895 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:13.937014 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:14.711991 18205 parameters.go:238] Clock(Monotonic): error: -395 ns, adjusted frequency from 2299775681 Hz to 2299773607 Hz I0229 18:31:14.712150 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:14.712323 18205 parameters.go:238] Clock(Realtime): error: -112 ns, adjusted frequency from 2299774621 Hz to 2299774366 Hz D0229 18:31:14.712473 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:14.712636 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:14.712535 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953062790680121 monotonicBaseRef:80000345853 monotonicFrequency:2299773607 realtimeReady:1 realtimeBaseCycles:8953062791464616 realtimeBaseRef:1583001074712311671 realtimeFrequency:2299774366} I0229 18:31:14.712832 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:14.712800 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:14.712986 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:14.713200 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:14.713379 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:15.712008 18205 parameters.go:238] Clock(Monotonic): error: -427 ns, adjusted frequency from 2299773607 Hz to 2299773564 Hz D0229 18:31:15.712250 18205 parameters.go:238] Clock(Realtime): error: 15 ns, adjusted frequency from 2299774366 Hz to 2299774551 Hz I0229 18:31:15.712314 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:15.712351 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953065090495817 monotonicBaseRef:81000364154 monotonicFrequency:2299773564 realtimeReady:1 realtimeBaseCycles:8953065091083315 realtimeBaseRef:1583001075712243983 realtimeFrequency:2299774551} D0229 18:31:15.712552 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:15.712708 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:15.712834 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:15.713119 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:15.713324 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:15.963911 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:15.964199 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:15.964353 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:15.964499 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:15.964484 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:15.964618 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:15.964826 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:15.964984 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:16.711924 18205 parameters.go:238] Clock(Monotonic): error: 117 ns, adjusted frequency from 2299773564 Hz to 2299774906 Hz D0229 18:31:16.712115 18205 parameters.go:238] Clock(Realtime): error: 36 ns, adjusted frequency from 2299774551 Hz to 2299774617 Hz D0229 18:31:16.712228 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953067390082141 monotonicBaseRef:82000282737 monotonicFrequency:2299774906 realtimeReady:1 realtimeBaseCycles:8953067390548229 realtimeBaseRef:1583001076712109345 realtimeFrequency:2299774617} I0229 18:31:16.935749 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:16.936036 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:16.936173 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:16.936383 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:16.936585 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:16.936681 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.142317 23459 main.go:305] *************************** I0229 18:31:17.142448 23459 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=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller699907402] I0229 18:31:17.142872 23459 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 18:31:17.142948 23459 main.go:308] PID: 23459 I0229 18:31:17.143032 23459 main.go:309] UID: 0, GID: 0 I0229 18:31:17.143122 23459 main.go:310] Configuration: I0229 18:31:17.143232 23459 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 18:31:17.143325 23459 main.go:312] Platform: ptrace I0229 18:31:17.143412 23459 main.go:313] FileAccess: shared, overlay: false I0229 18:31:17.143530 23459 main.go:314] Network: sandbox, logging: false I0229 18:31:17.143659 23459 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 18:31:17.143798 23459 main.go:316] *************************** W0229 18:31:17.143896 23459 main.go:321] Block the TERM signal. This is only safe in tests! D0229 18:31:17.144416 23459 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.152245 23459 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0229 18:31:17.152396 23459 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.152515 23459 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.152943 23459 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 18:31:17.152940 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.153195 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.153302 18205 urpc.go:577] urpc: unmarshal success. D0229 18:31:17.153373 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.153507 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.153831 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.154053 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.153536 18205 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 18:31:17.154659 18205 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 18:31:17.154834 23459 urpc.go:577] urpc: unmarshal success. D0229 18:31:17.155000 23459 exec.go:120] Exec arguments: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller699907402 D0229 18:31:17.155145 23459 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0229 18:31:17.155276 23459 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=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller699907402 D0229 18:31:17.155414 23459 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-0" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.155579 23459 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.156467 23459 urpc.go:534] urpc: successfully marshalled 634 bytes. D0229 18:31:17.156884 18205 urpc.go:577] urpc: unmarshal success. D0229 18:31:17.158274 18205 controller.go:267] containerManager.ExecuteAsync: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller699907402 D0229 18:31:17.158494 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0229 18:31:17.160088 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.160338 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 18:31:17.160995 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} I0229 18:31:17.161590 18205 kernel.go:797] EXEC: [/syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller699907402] D0229 18:31:17.162515 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0229 18:31:17.163858 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] 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: 1583000996, NanoSec: 30351875}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384251}]} D0229 18:31:17.164176 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0229 18:31:17.164944 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.165198 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 18:31:17.166167 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384251}, 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: 1583000996, NanoSec: 30351875}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 18:31:17.166352 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalk{FID: 5, NewFID: 6, Names: []} D0229 18:31:17.167209 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rwalk{QIDs: []} D0229 18:31:17.167360 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tlopen{FID: 6, Flags: ReadOnly} D0229 18:31:17.168560 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384251}, IoUnit: 0, File: &{{36}}} I0229 18:31:17.169478 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.173586 18205 syscalls.go:266] Allocating stack with size of 8388608 bytes D0229 18:31:17.175457 18205 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-0 0}:0xc00000e7a0 {ci-gvisor-ptrace-proxy-sandbox-race-0 23}:0xc00000e940] D0229 18:31:17.175838 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.175905 18205 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 18:31:17.176023 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.176052 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.176088 23459 urpc.go:577] urpc: unmarshal success. D0229 18:31:17.176311 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.176308 23459 container.go:580] Wait on PID 23 in container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.176474 23459 sandbox.go:761] Waiting for PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.176476 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.176597 23459 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:17.176984 23459 urpc.go:534] urpc: successfully marshalled 100 bytes. D0229 18:31:17.177764 18205 urpc.go:577] urpc: unmarshal success. D0229 18:31:17.178065 18205 controller.go:443] containerManager.Wait D0229 18:31:17.187081 18205 task_block.go:223] [ 23] Interrupt queued I0229 18:31:17.252200 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.252556 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.252699 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.252851 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.253028 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.253378 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.372170 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.372382 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.372565 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.372714 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.372941 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.373071 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.401258 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.401489 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.401642 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.401728 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.401943 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.402076 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.416625 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.416824 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.416946 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.417085 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.417288 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.417406 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.422005 18205 task_block.go:223] [ 24] Interrupt queued D0229 18:31:17.424974 18205 task_block.go:223] [ 25] Interrupt queued D0229 18:31:17.427504 18205 task_block.go:223] [ 26] Interrupt queued I0229 18:31:17.425943 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.428167 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.428338 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.428565 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:17.428662 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.428912 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.428958 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.429079 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.429155 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:17.430709 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.430901 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.430979 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.431111 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.431238 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:17.431292 18205 task_signals.go:452] [ 2] Notified of group signal 23 D0229 18:31:17.431420 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:17.431448 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.431606 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.431759 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.439039 18205 task_block.go:223] [ 27] Interrupt queued D0229 18:31:17.458122 18205 task_block.go:223] [ 28] Interrupt queued D0229 18:31:17.466327 18205 task_block.go:223] [ 29] Interrupt queued D0229 18:31:17.475074 18205 urpc.go:577] urpc: unmarshal success. D0229 18:31:17.475322 18205 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 18:31:17.475639 18205 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 18:31:17.499770 18205 task_block.go:223] [ 30] Interrupt queued D0229 18:31:17.515526 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0229 18:31:17.516304 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.516418 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 18:31:17.517196 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} I0229 18:31:17.535729 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.535997 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.536132 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.536202 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:17.536309 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.536435 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:17.536646 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.536803 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.536831 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.537064 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.537380 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:17.537608 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.537737 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.538224 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.538741 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.538969 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.537789 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.539291 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.539510 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.539747 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:17.539995 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:17.549910 18205 task_block.go:223] [ 31] Interrupt queued D0229 18:31:17.552240 18205 task_block.go:223] [ 32] Interrupt queued D0229 18:31:17.571819 18205 task_block.go:223] [ 33] Interrupt queued D0229 18:31:17.575909 18205 task_block.go:223] [ 34] Interrupt queued D0229 18:31:17.581171 18205 task_block.go:223] [ 35] Interrupt queued D0229 18:31:17.610830 18205 task_block.go:223] [ 36] Interrupt queued D0229 18:31:17.623027 18205 task_block.go:223] [ 37] Interrupt queued I0229 18:31:17.641018 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.641277 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.641457 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.641504 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.641806 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.641983 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.658334 18205 task_block.go:223] [ 38] Interrupt queued D0229 18:31:17.664423 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller699907402]} D0229 18:31:17.666803 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] 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: 227, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583001077, NanoSec: 106298192}, MTime: {Sec: 1583001077, NanoSec: 106298192}, CTime: {Sec: 1583001077, NanoSec: 106298192}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384250}]} I0229 18:31:17.667122 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.667465 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller699907402, Size: 1} D0229 18:31:17.667975 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.668148 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.668289 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.669385 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} I0229 18:31:17.669386 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.669465 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.669571 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.669598 18205 task_block.go:223] [ 39] Interrupt queued D0229 18:31:17.669602 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.669707 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.669738 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} I0229 18:31:17.669871 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.670016 18205 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 18:31:17.670183 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.670203 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.670303 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.670485 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:17.670658 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:17.670876 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384250}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 227, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583001077, NanoSec: 106298192}, MTime: {Sec: 1583001077, NanoSec: 106298192}, CTime: {Sec: 1583001077, NanoSec: 106298192}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 18:31:17.671089 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalk{FID: 7, NewFID: 8, Names: []} D0229 18:31:17.671840 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rwalk{QIDs: []} D0229 18:31:17.671999 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tlopen{FID: 8, Flags: ReadOnly} D0229 18:31:17.673049 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384250}, IoUnit: 0, File: &{{30}}} D0229 18:31:17.675953 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 18:31:17.677196 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384250}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 227, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583001077, NanoSec: 106298192}, MTime: {Sec: 1583001077, NanoSec: 106298192}, CTime: {Sec: 1583001077, NanoSec: 106298192}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/02/29 18:31:17 parsed 1 programs I0229 18:31:17.684589 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.684812 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.684944 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.685021 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.685184 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.685294 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.690691 18205 task_stop.go:118] [ 23] Entering internal stop (*kernel.vforkStop)(nil) D0229 18:31:17.691645 18205 task_block.go:223] [ 40] Interrupt queued D0229 18:31:17.697124 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0229 18:31:17.698809 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] 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: 1583000996, NanoSec: 34352267}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384295}]} D0229 18:31:17.699057 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0229 18:31:17.699641 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.699921 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 18:31:17.701225 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384295}, 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: 1583000996, NanoSec: 34352267}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 18:31:17.701424 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalk{FID: 9, NewFID: 10, Names: []} D0229 18:31:17.702230 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rwalk{QIDs: []} D0229 18:31:17.702381 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tlopen{FID: 10, Flags: ReadOnly} D0229 18:31:17.703311 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384295}, IoUnit: 0, File: &{{31}}} D0229 18:31:17.704259 18205 syscalls.go:266] [ 40] Allocating stack with size of 8388608 bytes I0229 18:31:17.704876 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.705106 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.705133 18205 task_stop.go:137] [ 23] Leaving internal stop (*kernel.vforkStop)(nil) D0229 18:31:17.705232 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.705370 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.705597 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.705704 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.711749 18205 parameters.go:238] Clock(Monotonic): error: 210 ns, adjusted frequency from 2299774906 Hz to 2299775006 Hz D0229 18:31:17.711973 18205 parameters.go:238] Clock(Realtime): error: -39 ns, adjusted frequency from 2299774617 Hz to 2299774535 Hz D0229 18:31:17.712117 18205 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8953069689473294 monotonicBaseRef:83000115871 monotonicFrequency:2299775006 realtimeReady:1 realtimeBaseCycles:8953069689997721 realtimeBaseRef:1583001077711967972 realtimeFrequency:2299774535} I0229 18:31:17.725538 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.725745 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.725885 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.725948 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.726221 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.726353 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.729250 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0229 18:31:17.730012 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.730199 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 18:31:17.730835 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.732263 18205 task_exit.go:221] [ 40] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:17.733940 18205 task_exit.go:221] [ 40] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:17.734106 18205 task_signals.go:446] [ 23] Notified of signal 17 D0229 18:31:17.734247 18205 task_block.go:223] [ 23] Interrupt queued D0229 18:31:17.734289 18205 task_block.go:223] [ 23] Interrupt queued D0229 18:31:17.734527 18205 task_signals.go:179] [ 23] Restarting syscall 247 after errno 512: interrupted by signal 17 D0229 18:31:17.734665 18205 task_signals.go:220] [ 23] Signal 17: delivering to handler D0229 18:31:17.735969 18205 task_exit.go:221] [ 40] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:17.738139 18205 task_block.go:223] [ 41] Interrupt queued D0229 18:31:17.745633 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0229 18:31:17.747116 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] 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: 1583000996, NanoSec: 34352267}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384295}]} D0229 18:31:17.747277 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tclunk{FID: 11} D0229 18:31:17.747829 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rclunk{} D0229 18:31:17.748140 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 18:31:17.749114 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384295}, 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: 1583000996, NanoSec: 34352267}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/02/29 18:31:17 executed programs: 0 I0229 18:31:17.761914 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.762256 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.762421 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.762549 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.762726 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.762862 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.762895 18205 task_stop.go:118] [ 34] Entering internal stop (*kernel.vforkStop)(nil) D0229 18:31:17.763917 18205 task_block.go:223] [ 42] Interrupt queued D0229 18:31:17.770494 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0229 18:31:17.771954 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] 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: 1583000996, NanoSec: 34352267}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384295}]} D0229 18:31:17.772160 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tclunk{FID: 11} D0229 18:31:17.772720 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rclunk{} I0229 18:31:17.772872 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.773111 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.773080 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 18:31:17.773358 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.773286 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.773663 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.773828 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.774252 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384295}, 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: 1583000996, NanoSec: 34352267}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 18:31:17.775633 18205 syscalls.go:266] [ 42] Allocating stack with size of 8388608 bytes D0229 18:31:17.777034 18205 task_stop.go:137] [ 34] Leaving internal stop (*kernel.vforkStop)(nil) I0229 18:31:17.781258 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.782240 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.783610 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.783635 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.783853 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 18:31:17.783825 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.784013 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.784064 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.784240 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.784530 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.784626 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.784656 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.784839 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:17.784956 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:17.791233 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0229 18:31:17.792032 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.792364 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 18:31:17.793049 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} I0229 18:31:17.798837 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.799106 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.799229 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.799387 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.799615 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.799727 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.807698 18205 task_block.go:223] [ 43] Interrupt queued D0229 18:31:17.814830 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.815584 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.815793 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.816261 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.816789 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.817432 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.817604 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.818230 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.819034 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} I0229 18:31:17.819164 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.819354 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.819548 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.819590 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.819609 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.819813 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.819865 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.819991 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.820488 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.820973 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.821571 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.821780 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.822249 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.822764 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.823261 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.823499 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.824014 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.824720 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.849539 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.849823 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.851191 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.851749 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.852467 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.852655 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.853166 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.853547 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.854091 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.854264 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.854810 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:17.855157 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:17.855700 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:17.855822 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:17.856349 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} I0229 18:31:17.860419 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.860694 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.860895 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.860944 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.861141 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.861259 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.875848 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.876162 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.876320 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.876451 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.877182 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.877308 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.884404 18205 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 18:31:17.884557 18205 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 0 D0229 18:31:17.884680 18205 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 0 D0229 18:31:17.884764 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.884868 18205 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]} D0229 18:31:17.885531 18205 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 18:31:17.885637 18205 netfilter.go:54] netfilter: convert to binary: found hook 2 at offset 152 D0229 18:31:17.885724 18205 netfilter.go:54] netfilter: convert to binary: found underflow 2 at offset 152 D0229 18:31:17.885833 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.885953 18205 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]} D0229 18:31:17.886506 18205 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 18:31:17.886596 18205 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0229 18:31:17.886686 18205 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0229 18:31:17.886831 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.886892 18205 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]} D0229 18:31:17.887378 18205 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0229 18:31:17.887463 18205 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]} D0229 18:31:17.888231 18205 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0229 18:31:17.888358 18205 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 18:31:17.888502 18205 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0229 18:31:17.888627 18205 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0229 18:31:17.888758 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.888897 18205 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]} D0229 18:31:17.889691 18205 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 18:31:17.889780 18205 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 152 D0229 18:31:17.889917 18205 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 152 D0229 18:31:17.890028 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.890134 18205 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]} D0229 18:31:17.890791 18205 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 18:31:17.890914 18205 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0229 18:31:17.891024 18205 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0229 18:31:17.891156 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.891289 18205 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]} D0229 18:31:17.892020 18205 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0229 18:31:17.892142 18205 netfilter.go:54] netfilter: convert to binary: found hook 4 at offset 456 D0229 18:31:17.892306 18205 netfilter.go:54] netfilter: convert to binary: found underflow 4 at offset 456 D0229 18:31:17.892448 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.892575 18205 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]} D0229 18:31:17.893345 18205 netfilter.go:54] netfilter: convert to binary: current offset: 608 D0229 18:31:17.893487 18205 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]} D0229 18:31:17.894308 18205 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0229 18:31:17.894453 18205 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 18:31:17.894549 18205 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0229 18:31:17.894664 18205 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0229 18:31:17.894821 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 18:31:17.894919 18205 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]} D0229 18:31:17.895504 18205 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 18:31:17.895580 18205 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 152 D0229 18:31:17.895681 18205 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 152 D0229 18:31:17.895818 18205 netfilter.go:54] netfilter: convert to binary: marshalling standard target I0229 18:31:17.896035 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.896241 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.896342 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.896403 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.895984 18205 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]} D0229 18:31:17.896792 18205 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 18:31:17.896619 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.896958 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.896909 18205 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]} D0229 18:31:17.897695 18205 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 I0229 18:31:17.916228 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.916435 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.916569 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.916654 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.916810 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.916908 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.936454 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.936636 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.936797 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.936814 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.937032 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.937168 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.951817 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.952761 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.953973 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.954098 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:17.954179 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.954304 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.954356 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.954425 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:17.954492 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.954945 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.955006 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:17.955054 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.955202 18205 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 18:31:17.955335 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 18:31:17.966778 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.967062 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.967232 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.967330 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.967512 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.967656 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:17.987046 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:17.987280 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:17.987441 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.987563 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:17.987772 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:17.987930 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.007411 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.007572 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.007683 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.007819 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.008031 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.008137 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.019515 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.019713 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.019834 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.019909 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.020077 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.020227 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.034844 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.035026 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.035182 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.035337 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.035476 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.035605 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.055757 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.055953 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.056102 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.056227 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.056411 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.056509 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.076034 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.076312 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.076538 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.076673 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.076872 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.076963 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.096209 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.096422 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.096556 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.096845 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.097025 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.097111 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.116359 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.116597 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.116752 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.116787 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.116959 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.117061 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:18.120969 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.121563 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.121741 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.122259 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.122540 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.122990 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.123118 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.123641 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.124059 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.124590 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.124779 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.125272 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.125534 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.128011 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.128258 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.128786 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.129104 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.129588 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.129730 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.130079 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.130288 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.130709 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.130851 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.131299 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.131580 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.132182 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.132355 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.132852 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.133191 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.133719 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.133929 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.134312 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.134633 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.135202 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.135345 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.135793 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.136085 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.136620 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.136897 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.137420 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.171026 18205 task_block.go:223] [ 44] Interrupt queued I0229 18:31:18.185601 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.185841 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.185988 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.186057 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.186336 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.186534 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 18:31:18.189327 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.189558 18205 task_signals.go:452] [ 2] Notified of group signal 23 D0229 18:31:18.189668 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:18.189690 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:18.189816 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.189973 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:18.190057 18205 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal D0229 18:31:18.197338 18205 task_block.go:223] [ 45] Interrupt queued D0229 18:31:18.217320 18205 task_block.go:223] [ 46] Interrupt queued D0229 18:31:18.229214 18205 task_block.go:223] [ 45] Interrupt queued D0229 18:31:18.229268 18205 task_block.go:223] [ 45] Interrupt queued D0229 18:31:18.229381 18205 task_block.go:223] [ 46] Interrupt queued D0229 18:31:18.229476 18205 task_block.go:223] [ 46] Interrupt queued D0229 18:31:18.229586 18205 task_exit.go:221] [ 44] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:18.229585 18205 task_signals.go:189] [ 45] Signal 9: terminating thread group D0229 18:31:18.229730 18205 task_signals.go:189] [ 46] Signal 9: terminating thread group D0229 18:31:18.229797 18205 task_exit.go:221] [ 44] Transitioning from exit state TaskExitInitiated to TaskExitZombie I0229 18:31:18.229779 18205 compat.go:129] Uncaught signal: "killed" (9), PID: 44, TID: 45, fault addr: 0x0 D0229 18:31:18.229988 18205 task_exit.go:221] [ 45] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 18:31:18.230024 18205 compat.go:129] Uncaught signal: "killed" (9), PID: 44, TID: 46, fault addr: 0x0 D0229 18:31:18.230192 18205 task_exit.go:221] [ 45] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:18.230395 18205 task_exit.go:221] [ 45] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.230620 18205 task_exit.go:221] [ 46] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:18.232935 18205 task_exit.go:221] [ 46] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:18.233101 18205 task_exit.go:221] [ 46] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.233279 18205 task_signals.go:419] [ 43] Discarding ignored signal 17 D0229 18:31:18.234477 18205 task_exit.go:221] [ 44] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.238741 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.239391 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.239732 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} I0229 18:31:18.240090 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.241923 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.242070 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.242262 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.242427 18205 task_block.go:223] [ 1] Interrupt queued I0229 18:31:18.242629 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.242670 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.242752 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.242797 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:18.242875 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.243114 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.243271 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:18.243294 18205 task_block.go:223] [ 2] Interrupt queued D0229 18:31:18.243394 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.243504 18205 task_signals.go:176] [ 2] Not restarting syscall 219 after errno 516: interrupted by signal 23 D0229 18:31:18.243626 18205 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 18:31:18.243758 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.243960 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.244402 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.245370 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.245874 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.246090 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.246516 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.255977 18205 task_block.go:223] [ 47] Interrupt queued I0229 18:31:18.261059 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.261376 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.261561 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.261664 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.261927 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.262041 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:18.269371 18205 task_block.go:223] [ 48] Interrupt queued D0229 18:31:18.289247 18205 task_block.go:223] [ 49] Interrupt queued D0229 18:31:18.295273 18205 task_block.go:223] [ 48] Interrupt queued D0229 18:31:18.295349 18205 task_block.go:223] [ 48] Interrupt queued D0229 18:31:18.295426 18205 task_block.go:223] [ 49] Interrupt queued D0229 18:31:18.295501 18205 task_exit.go:221] [ 47] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:18.295527 18205 task_block.go:223] [ 49] Interrupt queued D0229 18:31:18.295723 18205 task_exit.go:221] [ 47] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:18.295747 18205 task_signals.go:189] [ 48] Signal 9: terminating thread group D0229 18:31:18.295768 18205 task_signals.go:189] [ 49] Signal 9: terminating thread group I0229 18:31:18.295911 18205 compat.go:129] Uncaught signal: "killed" (9), PID: 47, TID: 48, fault addr: 0x0 D0229 18:31:18.296091 18205 task_exit.go:221] [ 48] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:18.296246 18205 task_exit.go:221] [ 48] Transitioning from exit state TaskExitInitiated to TaskExitZombie I0229 18:31:18.296174 18205 compat.go:129] Uncaught signal: "killed" (9), PID: 47, TID: 49, fault addr: 0x0 D0229 18:31:18.296343 18205 task_exit.go:221] [ 48] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.296520 18205 task_exit.go:221] [ 49] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:18.298171 18205 task_exit.go:221] [ 49] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:18.298336 18205 task_exit.go:221] [ 49] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.298507 18205 task_signals.go:419] [ 43] Discarding ignored signal 17 D0229 18:31:18.298770 18205 task_exit.go:221] [ 47] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.301541 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.302255 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.302432 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.302894 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.303563 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.304012 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.304177 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.304623 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.305228 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.305663 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.305790 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.306290 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} I0229 18:31:18.311255 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.311493 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.311606 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.311650 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.311872 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.311955 18205 task_block.go:223] [ 50] Interrupt queued D0229 18:31:18.312043 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:18.319678 18205 task_block.go:223] [ 51] Interrupt queued D0229 18:31:18.327489 18205 task_block.go:223] [ 52] Interrupt queued D0229 18:31:18.331472 18205 task_block.go:223] [ 51] Interrupt queued D0229 18:31:18.331514 18205 task_block.go:223] [ 51] Interrupt queued D0229 18:31:18.331608 18205 task_block.go:223] [ 52] Interrupt queued D0229 18:31:18.331675 18205 task_block.go:223] [ 52] Interrupt queued D0229 18:31:18.331746 18205 task_exit.go:221] [ 50] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:18.331957 18205 task_signals.go:189] [ 52] Signal 9: terminating thread group D0229 18:31:18.332117 18205 task_exit.go:221] [ 50] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:18.332096 18205 task_signals.go:189] [ 51] Signal 9: terminating thread group I0229 18:31:18.332351 18205 compat.go:129] Uncaught signal: "killed" (9), PID: 50, TID: 51, fault addr: 0x0 D0229 18:31:18.332553 18205 task_exit.go:221] [ 51] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 18:31:18.332569 18205 compat.go:129] Uncaught signal: "killed" (9), PID: 50, TID: 52, fault addr: 0x0 D0229 18:31:18.332763 18205 task_exit.go:221] [ 52] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 18:31:18.333037 18205 task_exit.go:221] [ 51] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:18.333198 18205 task_exit.go:221] [ 51] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.334183 18205 task_exit.go:221] [ 52] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 18:31:18.334352 18205 task_exit.go:221] [ 52] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.334532 18205 task_signals.go:419] [ 43] Discarding ignored signal 17 D0229 18:31:18.334705 18205 task_exit.go:221] [ 50] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 18:31:18.337657 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.338413 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.338617 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.339074 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.339987 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.340479 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.340625 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.341074 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.341669 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 18:31:18.342103 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 2} D0229 18:31:18.342270 18205 transport_flipcall.go:127] send [channel @0xc00026a3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 18:31:18.342797 18205 transport_flipcall.go:234] recv [channel @0xc00026a3c0] Rlerror{Error: 95} D0229 18:31:18.349408 18205 task_block.go:223] [ 53] Interrupt queued I0229 18:31:18.351595 18205 loader.go:566] Received external signal 23, mode: Process D0229 18:31:18.351760 18205 task_signals.go:446] [ 1] Notified of signal 23 D0229 18:31:18.351867 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.351929 18205 task_block.go:223] [ 1] Interrupt queued D0229 18:31:18.352194 18205 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 18:31:18.352324 18205 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 18:31:18.359520 18205 task_block.go:223] [ 54] Interrupt queued D0229 18:31:18.368124 18205 task_block.go:223] [ 55] Interrupt queued ================== WARNING: DATA RACE Write at 0x00c0002e4408 by goroutine 353: 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).coalescingRead() pkg/sentry/socket/netstack/netstack.go:2309 +0x67 gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).nonBlockingRead() pkg/sentry/socket/netstack/netstack.go:2378 +0x183f gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).Read() pkg/sentry/socket/netstack/netstack.go:442 +0x13c gvisor.dev/gvisor/pkg/sentry/fs.(*File).Readv() pkg/sentry/fs/file.go:270 +0x22f gvisor.dev/gvisor/pkg/sentry/syscalls/linux.readv() pkg/sentry/syscalls/linux/sys_read.go:292 +0xe0 DIAGNOSIS: I0229 18:31:18.408054 23727 main.go:305] *************************** I0229 18:31:18.408240 23727 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] I0229 18:31:18.408456 23727 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 18:31:18.408541 23727 main.go:308] PID: 23727 I0229 18:31:18.408636 23727 main.go:309] UID: 0, GID: 0 I0229 18:31:18.408726 23727 main.go:310] Configuration: I0229 18:31:18.408813 23727 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 18:31:18.408895 23727 main.go:312] Platform: ptrace I0229 18:31:18.408982 23727 main.go:313] FileAccess: shared, overlay: false I0229 18:31:18.409086 23727 main.go:314] Network: sandbox, logging: false I0229 18:31:18.409181 23727 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 18:31:18.409291 23727 main.go:316] *************************** W0229 18:31:18.409348 23727 main.go:321] Block the TERM signal. This is only safe in tests! D0229 18:31:18.409514 23727 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.416457 23727 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0229 18:31:18.416716 23727 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.416814 23727 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.417291 23727 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 18:31:18.492713 23727 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 18205 I0229 18:31:18.492862 23727 debug.go:131] Retrieving sandbox stacks D0229 18:31:18.492961 23727 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.493052 23727 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0229 18:31:18.493237 23727 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 18205: connection refused retrieving stacks: connecting to control server at PID 18205: connection refused W0229 18:31:18.493539 23727 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 I0229 18:31:18.408054 23727 main.go:305] *************************** I0229 18:31:18.408240 23727 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] I0229 18:31:18.408456 23727 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 18:31:18.408541 23727 main.go:308] PID: 23727 I0229 18:31:18.408636 23727 main.go:309] UID: 0, GID: 0 I0229 18:31:18.408726 23727 main.go:310] Configuration: I0229 18:31:18.408813 23727 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 18:31:18.408895 23727 main.go:312] Platform: ptrace I0229 18:31:18.408982 23727 main.go:313] FileAccess: shared, overlay: false I0229 18:31:18.409086 23727 main.go:314] Network: sandbox, logging: false I0229 18:31:18.409181 23727 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 18:31:18.409291 23727 main.go:316] *************************** W0229 18:31:18.409348 23727 main.go:321] Block the TERM signal. This is only safe in tests! D0229 18:31:18.409514 23727 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.416457 23727 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0229 18:31:18.416716 23727 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.416814 23727 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.417291 23727 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 18:31:18.492713 23727 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 18205 I0229 18:31:18.492862 23727 debug.go:131] Retrieving sandbox stacks D0229 18:31:18.492961 23727 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.493052 23727 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0229 18:31:18.493237 23727 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 18205: connection refused retrieving stacks: connecting to control server at PID 18205: connection refused W0229 18:31:18.493539 23727 main.go:338] Failure to execute command, err: 1 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Read() pkg/sentry/syscalls/linux/sys_read.go:72 +0x2ab gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall() pkg/sentry/kernel/task_syscall.go:170 +0x44d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke() pkg/sentry/kernel/task_syscall.go:291 +0xb4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter() pkg/sentry/kernel/task_syscall.go:252 +0x109 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall() pkg/sentry/kernel/task_syscall.go:227 +0x1b3 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute() pkg/sentry/kernel/task_run.go:232 +0x1aaa gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run() pkg/sentry/kernel/task_run.go:92 +0x320 Previous read at 0x00c0002e4408 by goroutine 344: 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 353 (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 344 (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 ================== W0229 18:31:18.484793 23459 error.go:48] FATAL ERROR: waiting on pid 23: waiting on PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 23: waiting on PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0": urpc method "containerManager.WaitPID" failed: EOF W0229 18:31:18.485344 23459 main.go:338] Failure to execute command, err: 1 W0229 18:31:18.492681 18196 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. D0229 18:31:18.492954 18196 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.493141 18196 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.493270 18196 sandbox.go:1058] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-0" by destroying sandbox D0229 18:31:18.493393 18196 sandbox.go:788] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 18:31:18.494235 18196 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 18204 I0229 18:31:18.595413 18196 main.go:329] Exiting with status: 16896