D0302 18:26:24.785525 30369 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0302 18:26:24.787517 30369 parameters.go:238] Clock(Monotonic): error: 556 ns, adjusted frequency from 2299774786 Hz to 2299775625 Hz D0302 18:26:24.787698 30369 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0302 18:26:24.787823 30369 parameters.go:238] Clock(Realtime): error: 274 ns, adjusted frequency from 2299774793 Hz to 2299775054 Hz D0302 18:26:24.787999 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349797084492999 monotonicBaseRef:3002598582 monotonicFrequency:2299775625 realtimeReady:1 realtimeBaseCycles:9349797085199901 realtimeBaseRef:1583173584787812480 realtimeFrequency:2299775054} I0302 18:26:25.503853 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:25.505496 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:25.505620 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:25.505677 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:25.505933 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:25.506138 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:26:25.785883 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:25.785278 30369 parameters.go:238] Clock(Monotonic): error: 52 ns, adjusted frequency from 2299775625 Hz to 2299774398 Hz D0302 18:26:25.787712 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:25.787799 30369 parameters.go:238] Clock(Realtime): error: 393 ns, adjusted frequency from 2299775054 Hz to 2299775277 Hz D0302 18:26:25.787898 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:25.787966 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:25.787974 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349799378595611 monotonicBaseRef:4000131813 monotonicFrequency:2299774398 realtimeReady:1 realtimeBaseCycles:9349799384921778 realtimeBaseRef:1583173585787789357 realtimeFrequency:2299775277} I0302 18:26:25.788058 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:25.788294 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:25.788415 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:25.788461 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:25.788602 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:25.789179 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:25.789238 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:25.789301 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:25.789507 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:26:25.789672 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:26:26.785444 30369 parameters.go:238] Clock(Monotonic): error: 343 ns, adjusted frequency from 2299774398 Hz to 2299775230 Hz D0302 18:26:26.785679 30369 parameters.go:238] Clock(Realtime): error: 139 ns, adjusted frequency from 2299775277 Hz to 2299774816 Hz D0302 18:26:26.785860 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349801679265976 monotonicBaseRef:5000521402 monotonicFrequency:2299775230 realtimeReady:1 realtimeBaseCycles:9349801679826503 realtimeBaseRef:1583173586785671518 realtimeFrequency:2299774816} D0302 18:26:27.785215 30369 parameters.go:238] Clock(Monotonic): error: -212 ns, adjusted frequency from 2299775230 Hz to 2299774044 Hz D0302 18:26:27.785481 30369 parameters.go:238] Clock(Realtime): error: 3 ns, adjusted frequency from 2299774816 Hz to 2299774545 Hz D0302 18:26:27.785642 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349803978463374 monotonicBaseRef:6000270146 monotonicFrequency:2299774044 realtimeReady:1 realtimeBaseCycles:9349803979149063 realtimeBaseRef:1583173587785474865 realtimeFrequency:2299774545} D0302 18:26:28.785268 30369 parameters.go:238] Clock(Monotonic): error: 177 ns, adjusted frequency from 2299774044 Hz to 2299774875 Hz D0302 18:26:28.785463 30369 parameters.go:238] Clock(Realtime): error: -254 ns, adjusted frequency from 2299774545 Hz to 2299773958 Hz D0302 18:26:28.785586 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349806278407310 monotonicBaseRef:7000344019 monotonicFrequency:2299774875 realtimeReady:1 realtimeBaseCycles:9349806278883144 realtimeBaseRef:1583173588785457270 realtimeFrequency:2299773958} I0302 18:26:29.502486 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:29.502809 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:29.502972 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:29.503007 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:29.503224 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:29.503344 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:29.785216 30369 parameters.go:238] Clock(Monotonic): error: 86 ns, adjusted frequency from 2299774875 Hz to 2299774725 Hz I0302 18:26:29.785325 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:29.785423 30369 parameters.go:238] Clock(Realtime): error: 54 ns, adjusted frequency from 2299773958 Hz to 2299774685 Hz D0302 18:26:29.785525 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:29.785528 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349808577996416 monotonicBaseRef:8000263241 monotonicFrequency:2299774725 realtimeReady:1 realtimeBaseCycles:9349808578565532 realtimeBaseRef:1583173589785417453 realtimeFrequency:2299774685} D0302 18:26:29.785642 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:29.785687 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:29.786147 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:29.786304 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:30.785782 30369 parameters.go:238] Clock(Monotonic): error: -145 ns, adjusted frequency from 2299774725 Hz to 2299774248 Hz D0302 18:26:30.786139 30369 parameters.go:238] Clock(Realtime): error: 96 ns, adjusted frequency from 2299774685 Hz to 2299774754 Hz D0302 18:26:30.786260 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349810879139898 monotonicBaseRef:9000858411 monotonicFrequency:2299774248 realtimeReady:1 realtimeBaseCycles:9349810879973721 realtimeBaseRef:1583173590786127741 realtimeFrequency:2299774754} I0302 18:26:31.502405 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:31.502649 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:31.502801 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:31.502998 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:31.503100 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:26:31.503095 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:31.503285 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:31.503510 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:31.785058 30369 parameters.go:238] Clock(Monotonic): error: 164 ns, adjusted frequency from 2299774248 Hz to 2299775051 Hz D0302 18:26:31.785282 30369 parameters.go:238] Clock(Realtime): error: 74 ns, adjusted frequency from 2299774754 Hz to 2299774813 Hz D0302 18:26:31.785377 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349813177247761 monotonicBaseRef:10000133824 monotonicFrequency:2299775051 realtimeReady:1 realtimeBaseCycles:9349813177789590 realtimeBaseRef:1583173591785275968 realtimeFrequency:2299774813} D0302 18:26:32.785267 30369 parameters.go:238] Clock(Monotonic): error: -149 ns, adjusted frequency from 2299775051 Hz to 2299774169 Hz I0302 18:26:32.785363 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:32.785637 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:32.785776 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:32.785458 30369 parameters.go:238] Clock(Realtime): error: -79 ns, adjusted frequency from 2299774813 Hz to 2299774447 Hz D0302 18:26:32.785985 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349815477512242 monotonicBaseRef:11000346640 monotonicFrequency:2299774169 realtimeReady:1 realtimeBaseCycles:9349815477963350 realtimeBaseRef:1583173592785449440 realtimeFrequency:2299774447} D0302 18:26:32.786260 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:32.786458 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:32.786568 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:33.785147 30369 parameters.go:238] Clock(Monotonic): error: 207 ns, adjusted frequency from 2299774169 Hz to 2299775055 Hz D0302 18:26:33.785373 30369 parameters.go:238] Clock(Realtime): error: 400 ns, adjusted frequency from 2299774447 Hz to 2299775557 Hz D0302 18:26:33.785512 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349817777010224 monotonicBaseRef:12000226546 monotonicFrequency:2299775055 realtimeReady:1 realtimeBaseCycles:9349817777545363 realtimeBaseRef:1583173593785365764 realtimeFrequency:2299775557} I0302 18:26:34.536391 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:34.536637 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:34.536784 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:34.536821 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:34.536949 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:34.537028 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:34.537086 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:34.537164 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:34.537219 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:34.537681 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:34.537848 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:34.538349 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:34.538496 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:34.785205 30369 parameters.go:238] Clock(Monotonic): error: 360 ns, adjusted frequency from 2299775055 Hz to 2299775505 Hz D0302 18:26:34.785482 30369 parameters.go:238] Clock(Realtime): error: -102 ns, adjusted frequency from 2299775557 Hz to 2299774466 Hz D0302 18:26:34.785654 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349820076907530 monotonicBaseRef:13000279703 monotonicFrequency:2299775505 realtimeReady:1 realtimeBaseCycles:9349820077570095 realtimeBaseRef:1583173594785474111 realtimeFrequency:2299774466} D0302 18:26:35.785207 30369 parameters.go:238] Clock(Monotonic): error: -388 ns, adjusted frequency from 2299775505 Hz to 2299773728 Hz I0302 18:26:35.785317 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:35.785472 30369 parameters.go:238] Clock(Realtime): error: -127 ns, adjusted frequency from 2299774466 Hz to 2299774342 Hz D0302 18:26:35.785618 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:35.785649 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349822376687623 monotonicBaseRef:14000281697 monotonicFrequency:2299773728 realtimeReady:1 realtimeBaseCycles:9349822377319946 realtimeBaseRef:1583173595785463407 realtimeFrequency:2299774342} D0302 18:26:35.785781 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:35.785831 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:35.785991 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:35.786071 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:35.786173 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:35.786269 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:35.786370 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:35.786797 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:35.786936 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:35.786926 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:35.787266 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:26:35.787428 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:26:36.785676 30369 parameters.go:238] Clock(Monotonic): error: 138 ns, adjusted frequency from 2299773728 Hz to 2299774904 Hz D0302 18:26:36.785951 30369 parameters.go:238] Clock(Realtime): error: 88 ns, adjusted frequency from 2299774342 Hz to 2299774810 Hz D0302 18:26:36.786127 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349824677551851 monotonicBaseRef:15000755874 monotonicFrequency:2299774904 realtimeReady:1 realtimeBaseCycles:9349824678194569 realtimeBaseRef:1583173596785941836 realtimeFrequency:2299774810} I0302 18:26:37.504001 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:37.504206 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:37.504303 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:37.504349 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:37.504555 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:37.504701 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:26:37.515240 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:37.515465 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:37.515610 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:37.515743 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:37.515997 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:37.516093 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:37.785212 30369 parameters.go:238] Clock(Monotonic): error: 74 ns, adjusted frequency from 2299774904 Hz to 2299774837 Hz I0302 18:26:37.785337 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:37.785418 30369 parameters.go:238] Clock(Realtime): error: -138 ns, adjusted frequency from 2299774810 Hz to 2299774337 Hz D0302 18:26:37.785522 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:37.785540 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349826976205586 monotonicBaseRef:16000268361 monotonicFrequency:2299774837 realtimeReady:1 realtimeBaseCycles:9349826976750202 realtimeBaseRef:1583173597785411707 realtimeFrequency:2299774337} D0302 18:26:37.785713 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:37.785799 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:37.785911 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:37.785989 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:37.786068 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:37.786089 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:37.786180 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:37.786498 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:37.786541 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:37.786622 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:37.786822 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:26:37.787010 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 18:26:38.502642 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:38.502867 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:38.503000 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:38.503114 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:38.503200 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:26:38.503161 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:38.503359 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:38.503475 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:38.785121 30369 parameters.go:238] Clock(Monotonic): error: -202 ns, adjusted frequency from 2299774837 Hz to 2299774244 Hz D0302 18:26:38.785480 30369 parameters.go:238] Clock(Realtime): error: -269 ns, adjusted frequency from 2299774337 Hz to 2299774062 Hz D0302 18:26:38.785662 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349829275806715 monotonicBaseRef:17000192828 monotonicFrequency:2299774244 realtimeReady:1 realtimeBaseCycles:9349829276626732 realtimeBaseRef:1583173598785456143 realtimeFrequency:2299774062} I0302 18:26:39.502411 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:39.502634 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:39.502801 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:39.502979 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:39.503177 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:39.503316 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:26:39.785334 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:39.785252 30369 parameters.go:238] Clock(Monotonic): error: 188 ns, adjusted frequency from 2299774244 Hz to 2299775010 Hz D0302 18:26:39.785602 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:39.785728 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:39.785684 30369 parameters.go:238] Clock(Realtime): error: 227 ns, adjusted frequency from 2299774062 Hz to 2299775242 Hz D0302 18:26:39.785770 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:39.785851 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:39.785846 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349831575878829 monotonicBaseRef:18000322349 monotonicFrequency:2299775010 realtimeReady:1 realtimeBaseCycles:9349831576893649 realtimeBaseRef:1583173599785670448 realtimeFrequency:2299775242} D0302 18:26:39.785994 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:26:39.786260 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:39.786425 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:26:40.502496 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:40.502739 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:40.502926 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:40.503054 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:40.503275 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:40.503408 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:40.785135 30369 parameters.go:238] Clock(Monotonic): error: -162 ns, adjusted frequency from 2299775010 Hz to 2299774281 Hz D0302 18:26:40.785437 30369 parameters.go:238] Clock(Realtime): error: 140 ns, adjusted frequency from 2299775242 Hz to 2299774956 Hz D0302 18:26:40.785604 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349833875396721 monotonicBaseRef:19000210547 monotonicFrequency:2299774281 realtimeReady:1 realtimeBaseCycles:9349833876115336 realtimeBaseRef:1583173600785429748 realtimeFrequency:2299774956} I0302 18:26:41.502474 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:41.502767 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:41.502938 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:41.502980 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:41.503166 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:41.503278 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:41.785104 30369 parameters.go:238] Clock(Monotonic): error: 183 ns, adjusted frequency from 2299774281 Hz to 2299775138 Hz D0302 18:26:41.785337 30369 parameters.go:238] Clock(Realtime): error: 43 ns, adjusted frequency from 2299774956 Hz to 2299774734 Hz D0302 18:26:41.785493 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349836175093794 monotonicBaseRef:20000176975 monotonicFrequency:2299775138 realtimeReady:1 realtimeBaseCycles:9349836175660052 realtimeBaseRef:1583173601785329633 realtimeFrequency:2299774734} D0302 18:26:42.785176 30369 parameters.go:238] Clock(Monotonic): error: 180 ns, adjusted frequency from 2299775138 Hz to 2299775122 Hz I0302 18:26:42.785248 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:42.785375 30369 parameters.go:238] Clock(Realtime): error: -65 ns, adjusted frequency from 2299774734 Hz to 2299774525 Hz D0302 18:26:42.785461 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:42.785518 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349838475037979 monotonicBaseRef:21000250480 monotonicFrequency:2299775122 realtimeReady:1 realtimeBaseCycles:9349838475522824 realtimeBaseRef:1583173602785367914 realtimeFrequency:2299774525} D0302 18:26:42.785600 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:42.785756 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:42.785841 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:42.785969 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:42.785991 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:42.786098 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:42.786127 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:42.786580 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:42.786733 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:42.786749 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:42.786988 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:26:42.787117 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:26:43.785241 30369 parameters.go:238] Clock(Monotonic): error: -444 ns, adjusted frequency from 2299775122 Hz to 2299773715 Hz D0302 18:26:43.785507 30369 parameters.go:238] Clock(Realtime): error: 92 ns, adjusted frequency from 2299774525 Hz to 2299774851 Hz D0302 18:26:43.785655 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349840774956017 monotonicBaseRef:22000312623 monotonicFrequency:2299773715 realtimeReady:1 realtimeBaseCycles:9349840775599991 realtimeBaseRef:1583173603785499510 realtimeFrequency:2299774851} I0302 18:26:44.536242 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:44.536590 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:44.536713 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:44.536824 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:44.536830 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:44.536941 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:26:44.537051 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:44.537249 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:44.785169 30369 parameters.go:238] Clock(Monotonic): error: 181 ns, adjusted frequency from 2299773715 Hz to 2299775053 Hz D0302 18:26:44.785374 30369 parameters.go:238] Clock(Realtime): error: -167 ns, adjusted frequency from 2299774851 Hz to 2299774247 Hz D0302 18:26:44.785474 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349843074580627 monotonicBaseRef:23000247788 monotonicFrequency:2299775053 realtimeReady:1 realtimeBaseCycles:9349843075044683 realtimeBaseRef:1583173604785355948 realtimeFrequency:2299774247} I0302 18:26:45.502394 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:45.502639 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:45.502768 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:45.502906 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:45.503164 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:45.503303 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:45.785453 30369 parameters.go:238] Clock(Monotonic): error: 181 ns, adjusted frequency from 2299775053 Hz to 2299775088 Hz D0302 18:26:45.785720 30369 parameters.go:238] Clock(Realtime): error: 151 ns, adjusted frequency from 2299774247 Hz to 2299775040 Hz D0302 18:26:45.785885 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349845374987625 monotonicBaseRef:24000522573 monotonicFrequency:2299775088 realtimeReady:1 realtimeBaseCycles:9349845375642346 realtimeBaseRef:1583173605785713990 realtimeFrequency:2299775040} D0302 18:26:46.785148 30369 parameters.go:238] Clock(Monotonic): error: -145 ns, adjusted frequency from 2299775088 Hz to 2299774322 Hz D0302 18:26:46.785388 30369 parameters.go:238] Clock(Realtime): error: -148 ns, adjusted frequency from 2299775040 Hz to 2299774314 Hz D0302 18:26:46.785522 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349847674073212 monotonicBaseRef:25000222760 monotonicFrequency:2299774322 realtimeReady:1 realtimeBaseCycles:9349847674653597 realtimeBaseRef:1583173606785381875 realtimeFrequency:2299774314} I0302 18:26:47.502401 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:47.502645 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:47.502782 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:47.502865 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:47.503068 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:47.503173 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:47.785244 30369 parameters.go:238] Clock(Monotonic): error: -139 ns, adjusted frequency from 2299774322 Hz to 2299774324 Hz I0302 18:26:47.785441 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:47.785487 30369 parameters.go:238] Clock(Realtime): error: 166 ns, adjusted frequency from 2299774314 Hz to 2299775021 Hz D0302 18:26:47.785627 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:47.785778 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:47.785656 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349849973996503 monotonicBaseRef:26000287535 monotonicFrequency:2299774324 realtimeReady:1 realtimeBaseCycles:9349849974651791 realtimeBaseRef:1583173607785479223 realtimeFrequency:2299775021} D0302 18:26:47.785847 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:47.785947 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:47.786118 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:26:47.786273 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:47.786401 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:48.785174 30369 parameters.go:238] Clock(Monotonic): error: 465 ns, adjusted frequency from 2299774324 Hz to 2299775752 Hz D0302 18:26:48.785377 30369 parameters.go:238] Clock(Realtime): error: -185 ns, adjusted frequency from 2299775021 Hz to 2299774214 Hz D0302 18:26:48.785509 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349852273680321 monotonicBaseRef:27000248180 monotonicFrequency:2299775752 realtimeReady:1 realtimeBaseCycles:9349852274180103 realtimeBaseRef:1583173608785371947 realtimeFrequency:2299774214} D0302 18:26:49.785211 30369 parameters.go:238] Clock(Monotonic): error: -199 ns, adjusted frequency from 2299775752 Hz to 2299774112 Hz I0302 18:26:49.785317 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:49.785489 30369 parameters.go:238] Clock(Realtime): error: 263 ns, adjusted frequency from 2299774214 Hz to 2299775288 Hz D0302 18:26:49.785540 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:49.785631 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349854573483777 monotonicBaseRef:28000260226 monotonicFrequency:2299774112 realtimeReady:1 realtimeBaseCycles:9349854574206912 realtimeBaseRef:1583173609785481781 realtimeFrequency:2299775288} D0302 18:26:49.785672 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:49.785770 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:49.785888 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:49.786011 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:49.786079 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:49.786120 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:49.786209 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:49.786484 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:49.786515 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:49.786560 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:49.786806 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:26:49.786922 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:26:50.785167 30369 parameters.go:238] Clock(Monotonic): error: 159 ns, adjusted frequency from 2299774112 Hz to 2299775063 Hz D0302 18:26:50.785377 30369 parameters.go:238] Clock(Realtime): error: -182 ns, adjusted frequency from 2299775288 Hz to 2299774253 Hz D0302 18:26:50.785637 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349856873204559 monotonicBaseRef:29000237036 monotonicFrequency:2299775063 realtimeReady:1 realtimeBaseCycles:9349856873727613 realtimeBaseRef:1583173610785371080 realtimeFrequency:2299774253} D0302 18:26:51.785177 30369 parameters.go:238] Clock(Monotonic): error: -470 ns, adjusted frequency from 2299775063 Hz to 2299773644 Hz D0302 18:26:51.785428 30369 parameters.go:238] Clock(Realtime): error: 57 ns, adjusted frequency from 2299774253 Hz to 2299774770 Hz D0302 18:26:51.785658 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349859173007770 monotonicBaseRef:30000249275 monotonicFrequency:2299773644 realtimeReady:1 realtimeBaseCycles:9349859173615989 realtimeBaseRef:1583173611785420703 realtimeFrequency:2299774770} I0302 18:26:51.786016 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:51.786294 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:51.786458 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:51.786495 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:51.786766 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:51.786883 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:26:51.825769 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:51.826025 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:51.826182 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:51.826357 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:51.826772 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:51.827001 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:52.785219 30369 parameters.go:238] Clock(Monotonic): error: 328 ns, adjusted frequency from 2299773644 Hz to 2299775336 Hz D0302 18:26:52.785462 30369 parameters.go:238] Clock(Realtime): error: 72 ns, adjusted frequency from 2299774770 Hz to 2299774840 Hz D0302 18:26:52.785611 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349861472880724 monotonicBaseRef:31000292457 monotonicFrequency:2299775336 realtimeReady:1 realtimeBaseCycles:9349861473470643 realtimeBaseRef:1583173612785455438 realtimeFrequency:2299774840} D0302 18:26:53.785750 30369 parameters.go:238] Clock(Monotonic): error: -210 ns, adjusted frequency from 2299775336 Hz to 2299774200 Hz D0302 18:26:53.785966 30369 parameters.go:238] Clock(Realtime): error: -79 ns, adjusted frequency from 2299774840 Hz to 2299774523 Hz D0302 18:26:53.786091 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349863773881595 monotonicBaseRef:32000825350 monotonicFrequency:2299774200 realtimeReady:1 realtimeBaseCycles:9349863774402123 realtimeBaseRef:1583173613785958374 realtimeFrequency:2299774523} I0302 18:26:53.786577 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:53.786783 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:53.786872 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:53.786986 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:53.787259 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:53.787427 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:26:54.535668 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:54.535920 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:54.536086 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:54.536213 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:54.536365 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:54.536455 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:26:54.545271 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:54.545581 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:54.545734 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:54.545883 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:54.546124 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:54.546294 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:54.785249 30369 parameters.go:238] Clock(Monotonic): error: 96 ns, adjusted frequency from 2299774200 Hz to 2299774877 Hz D0302 18:26:54.785464 30369 parameters.go:238] Clock(Realtime): error: -55 ns, adjusted frequency from 2299774523 Hz to 2299774505 Hz D0302 18:26:54.785583 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349866072502254 monotonicBaseRef:33000323761 monotonicFrequency:2299774877 realtimeReady:1 realtimeBaseCycles:9349866073025154 realtimeBaseRef:1583173614785457676 realtimeFrequency:2299774505} D0302 18:26:55.785257 30369 parameters.go:238] Clock(Monotonic): error: 79 ns, adjusted frequency from 2299774877 Hz to 2299774814 Hz I0302 18:26:55.785414 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:55.785748 30369 parameters.go:238] Clock(Realtime): error: 312 ns, adjusted frequency from 2299774505 Hz to 2299775342 Hz D0302 18:26:55.785834 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:55.785967 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:55.785916 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349868372242552 monotonicBaseRef:34000308725 monotonicFrequency:2299774814 realtimeReady:1 realtimeBaseCycles:9349868373447620 realtimeBaseRef:1583173615785739425 realtimeFrequency:2299775342} I0302 18:26:55.786099 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:55.786031 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:55.786229 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:26:55.786360 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:55.786577 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:56.785208 30369 parameters.go:238] Clock(Monotonic): error: -258 ns, adjusted frequency from 2299774814 Hz to 2299773919 Hz D0302 18:26:56.785452 30369 parameters.go:238] Clock(Realtime): error: -100 ns, adjusted frequency from 2299775342 Hz to 2299774421 Hz D0302 18:26:56.785618 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349870671956679 monotonicBaseRef:35000282336 monotonicFrequency:2299773919 realtimeReady:1 realtimeBaseCycles:9349870672544789 realtimeBaseRef:1583173616785444538 realtimeFrequency:2299774421} I0302 18:26:57.502291 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:57.502497 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:57.502618 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:57.502628 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:57.503012 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:57.503254 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:57.785187 30369 parameters.go:238] Clock(Monotonic): error: 395 ns, adjusted frequency from 2299773919 Hz to 2299775593 Hz I0302 18:26:57.785281 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:57.785409 30369 parameters.go:238] Clock(Realtime): error: -285 ns, adjusted frequency from 2299774421 Hz to 2299774011 Hz D0302 18:26:57.785528 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:57.785582 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349872971621165 monotonicBaseRef:36000234751 monotonicFrequency:2299775593 realtimeReady:1 realtimeBaseCycles:9349872972222871 realtimeBaseRef:1583173617785402647 realtimeFrequency:2299774011} D0302 18:26:57.785708 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:57.785749 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:26:57.786359 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:57.786819 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:57.787617 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:57.786889 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0302 18:26:57.788663 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:57.788669 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:26:57.788807 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:26:57.789241 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:57.789348 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:26:57.789413 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:57.789563 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:26:57.789710 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:26:57.809335 30369 urpc.go:577] urpc: unmarshal success. D0302 18:26:57.810280 30369 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0302 18:26:57.810615 30369 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 18:26:58.785302 30369 parameters.go:238] Clock(Monotonic): error: 187 ns, adjusted frequency from 2299775593 Hz to 2299775141 Hz D0302 18:26:58.785529 30369 parameters.go:238] Clock(Realtime): error: 177 ns, adjusted frequency from 2299774011 Hz to 2299775065 Hz D0302 18:26:58.785721 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349875271728875 monotonicBaseRef:37000379163 monotonicFrequency:2299775141 realtimeReady:1 realtimeBaseCycles:9349875272273714 realtimeBaseRef:1583173618785523020 realtimeFrequency:2299775065} D0302 18:26:59.785223 30369 parameters.go:238] Clock(Monotonic): error: -379 ns, adjusted frequency from 2299775141 Hz to 2299773737 Hz I0302 18:26:59.785313 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:26:59.785467 30369 parameters.go:238] Clock(Realtime): error: -79 ns, adjusted frequency from 2299775065 Hz to 2299774467 Hz D0302 18:26:59.785564 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:26:59.785720 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:59.785658 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349877571311845 monotonicBaseRef:38000295602 monotonicFrequency:2299773737 realtimeReady:1 realtimeBaseCycles:9349877571905628 realtimeBaseRef:1583173619785460774 realtimeFrequency:2299774467} D0302 18:26:59.785788 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:26:59.786091 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:26:59.786282 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:00.502440 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:00.502672 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:00.502788 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:00.502927 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:00.502964 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:00.503125 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:00.503110 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:00.503219 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:00.503238 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:00.503617 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:00.503629 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:00.503722 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:00.503843 30369 task_signals.go:176] [ 2] Not restarting syscall 270 after errno 514: interrupted by signal 23 D0302 18:27:00.503998 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:00.785249 30369 parameters.go:238] Clock(Monotonic): error: 19 ns, adjusted frequency from 2299773737 Hz to 2299774651 Hz I0302 18:27:00.785383 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:00.785501 30369 parameters.go:238] Clock(Realtime): error: 248 ns, adjusted frequency from 2299774467 Hz to 2299775269 Hz D0302 18:27:00.785624 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:00.785760 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:00.785672 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349879871152995 monotonicBaseRef:39000324914 monotonicFrequency:2299774651 realtimeReady:1 realtimeBaseCycles:9349879871757990 realtimeBaseRef:1583173620785494644 realtimeFrequency:2299775269} D0302 18:27:00.785877 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:00.786157 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:00.786323 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:01.502333 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:01.502583 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:01.502693 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:01.502874 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:01.502890 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:01.503018 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:01.503178 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:01.503351 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:01.785170 30369 parameters.go:238] Clock(Monotonic): error: -112 ns, adjusted frequency from 2299774651 Hz to 2299774423 Hz D0302 18:27:01.785387 30369 parameters.go:238] Clock(Realtime): error: -447 ns, adjusted frequency from 2299775269 Hz to 2299773625 Hz D0302 18:27:01.785511 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349882170707154 monotonicBaseRef:40000229038 monotonicFrequency:2299774423 realtimeReady:1 realtimeBaseCycles:9349882171270994 realtimeBaseRef:1583173621785380604 realtimeFrequency:2299773625} I0302 18:27:02.503087 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:02.503354 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:02.503514 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:02.503698 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:02.503875 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:02.504071 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:02.505184 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:02.505378 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:02.505488 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:02.505632 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:02.505873 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:02.506024 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:02.785140 30369 parameters.go:238] Clock(Monotonic): error: 413 ns, adjusted frequency from 2299774423 Hz to 2299775670 Hz D0302 18:27:02.785368 30369 parameters.go:238] Clock(Realtime): error: 368 ns, adjusted frequency from 2299773625 Hz to 2299775516 Hz D0302 18:27:02.785502 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349884470456980 monotonicBaseRef:41000218342 monotonicFrequency:2299775670 realtimeReady:1 realtimeBaseCycles:9349884471000994 realtimeBaseRef:1583173622785361634 realtimeFrequency:2299775516} D0302 18:27:03.785151 30369 parameters.go:238] Clock(Monotonic): error: -422 ns, adjusted frequency from 2299775670 Hz to 2299773705 Hz D0302 18:27:03.785383 30369 parameters.go:238] Clock(Realtime): error: -83 ns, adjusted frequency from 2299775516 Hz to 2299774516 Hz D0302 18:27:03.785953 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349886770255046 monotonicBaseRef:42000228080 monotonicFrequency:2299773705 realtimeReady:1 realtimeBaseCycles:9349886770811407 realtimeBaseRef:1583173623785376808 realtimeFrequency:2299774516} I0302 18:27:04.536084 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:04.536319 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:04.536476 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:04.536644 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:04.536587 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:04.536793 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:04.536969 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:04.537177 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:04.785128 30369 parameters.go:238] Clock(Monotonic): error: 228 ns, adjusted frequency from 2299773705 Hz to 2299775224 Hz D0302 18:27:04.785342 30369 parameters.go:238] Clock(Realtime): error: -228 ns, adjusted frequency from 2299774516 Hz to 2299774174 Hz D0302 18:27:04.785434 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349889069964986 monotonicBaseRef:43000200353 monotonicFrequency:2299775224 realtimeReady:1 realtimeBaseCycles:9349889070490168 realtimeBaseRef:1583173624785335171 realtimeFrequency:2299774174} I0302 18:27:05.502928 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:05.503222 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:05.503379 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:05.503556 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:05.503793 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:05.503960 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:05.785214 30369 parameters.go:238] Clock(Monotonic): error: -463 ns, adjusted frequency from 2299775224 Hz to 2299773736 Hz D0302 18:27:05.785427 30369 parameters.go:238] Clock(Realtime): error: 172 ns, adjusted frequency from 2299774174 Hz to 2299775065 Hz I0302 18:27:05.785320 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:05.785581 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349891369950397 monotonicBaseRef:44000291747 monotonicFrequency:2299773736 realtimeReady:1 realtimeBaseCycles:9349891370458672 realtimeBaseRef:1583173625785419670 realtimeFrequency:2299775065} D0302 18:27:05.785674 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:05.785819 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:05.785950 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:05.786000 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:05.786118 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:05.786293 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:05.786456 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:06.785094 30369 parameters.go:238] Clock(Monotonic): error: -128 ns, adjusted frequency from 2299773736 Hz to 2299774386 Hz I0302 18:27:06.785162 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:06.785372 30369 parameters.go:238] Clock(Realtime): error: -259 ns, adjusted frequency from 2299775065 Hz to 2299774050 Hz D0302 18:27:06.785441 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:06.785524 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349893669387978 monotonicBaseRef:45000145578 monotonicFrequency:2299774386 realtimeReady:1 realtimeBaseCycles:9349893670109362 realtimeBaseRef:1583173626785365588 realtimeFrequency:2299774050} D0302 18:27:06.785683 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:06.785733 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:06.786067 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:06.786305 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:07.785173 30369 parameters.go:238] Clock(Monotonic): error: 489 ns, adjusted frequency from 2299774386 Hz to 2299775761 Hz I0302 18:27:07.785302 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:07.785442 30369 parameters.go:238] Clock(Realtime): error: 196 ns, adjusted frequency from 2299774050 Hz to 2299775088 Hz D0302 18:27:07.785570 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:07.785601 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349895969329490 monotonicBaseRef:46000218248 monotonicFrequency:2299775761 realtimeReady:1 realtimeBaseCycles:9349895970041896 realtimeBaseRef:1583173627785434500 realtimeFrequency:2299775088} D0302 18:27:07.785737 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:07.785893 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:07.786192 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:07.786343 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:08.179563 30369 watchdog.go:277] Watchdog starting loop, tasks: 17, discount: 0s I0302 18:27:08.502352 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:08.502581 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:08.502761 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:08.502909 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:08.503133 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:08.503258 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:08.785155 30369 parameters.go:238] Clock(Monotonic): error: -90 ns, adjusted frequency from 2299775761 Hz to 2299774488 Hz D0302 18:27:08.785381 30369 parameters.go:238] Clock(Realtime): error: 180 ns, adjusted frequency from 2299775088 Hz to 2299775114 Hz I0302 18:27:08.785342 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:08.785640 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:08.785555 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349898269142157 monotonicBaseRef:47000234295 monotonicFrequency:2299774488 realtimeReady:1 realtimeBaseCycles:9349898269677975 realtimeBaseRef:1583173628785374055 realtimeFrequency:2299775114} D0302 18:27:08.785769 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:08.785893 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:08.786017 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:08.786208 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:08.786248 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:08.786384 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:08.786420 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:08.787051 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:08.787025 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:08.787401 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:08.787636 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:08.787935 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:09.785150 30369 parameters.go:238] Clock(Monotonic): error: 15 ns, adjusted frequency from 2299774488 Hz to 2299774618 Hz I0302 18:27:09.785324 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:09.785415 30369 parameters.go:238] Clock(Realtime): error: -294 ns, adjusted frequency from 2299775114 Hz to 2299773946 Hz D0302 18:27:09.785538 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:09.785543 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349900568898213 monotonicBaseRef:48000226280 monotonicFrequency:2299774618 realtimeReady:1 realtimeBaseCycles:9349900569531645 realtimeBaseRef:1583173629785408213 realtimeFrequency:2299773946} D0302 18:27:09.785730 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:09.785841 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:09.785976 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:09.786104 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:09.786200 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:09.786329 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:09.786348 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:09.786794 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:09.786943 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:09.787398 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:09.787411 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:09.787615 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:09.787780 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 18:27:10.502577 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:10.502800 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:10.502895 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:10.502925 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:10.503105 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:10.503267 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:10.785161 30369 parameters.go:238] Clock(Monotonic): error: -95 ns, adjusted frequency from 2299774618 Hz to 2299774420 Hz D0302 18:27:10.785983 30369 parameters.go:238] Clock(Realtime): error: 100 ns, adjusted frequency from 2299773946 Hz to 2299774889 Hz D0302 18:27:10.786117 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349902868707198 monotonicBaseRef:49000241223 monotonicFrequency:2299774420 realtimeReady:1 realtimeBaseCycles:9349902870609406 realtimeBaseRef:1583173630785975144 realtimeFrequency:2299774889} D0302 18:27:11.785141 30369 parameters.go:238] Clock(Monotonic): error: 276 ns, adjusted frequency from 2299774420 Hz to 2299775259 Hz D0302 18:27:11.785327 30369 parameters.go:238] Clock(Realtime): error: 50 ns, adjusted frequency from 2299774889 Hz to 2299774749 Hz D0302 18:27:11.785472 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349905168430193 monotonicBaseRef:50000218862 monotonicFrequency:2299775259 realtimeReady:1 realtimeBaseCycles:9349905168880399 realtimeBaseRef:1583173631785321212 realtimeFrequency:2299774749} D0302 18:27:12.785048 30369 parameters.go:238] Clock(Monotonic): error: -396 ns, adjusted frequency from 2299775259 Hz to 2299773813 Hz D0302 18:27:12.785308 30369 parameters.go:238] Clock(Realtime): error: -41 ns, adjusted frequency from 2299774749 Hz to 2299774519 Hz D0302 18:27:12.785448 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349907467988303 monotonicBaseRef:51000124440 monotonicFrequency:2299773813 realtimeReady:1 realtimeBaseCycles:9349907468604440 realtimeBaseRef:1583173632785299162 realtimeFrequency:2299774519} D0302 18:27:13.785167 30369 parameters.go:238] Clock(Monotonic): error: 463 ns, adjusted frequency from 2299773813 Hz to 2299775718 Hz D0302 18:27:13.785459 30369 parameters.go:238] Clock(Realtime): error: 287 ns, adjusted frequency from 2299774519 Hz to 2299775288 Hz D0302 18:27:13.785603 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349909768035864 monotonicBaseRef:52000243472 monotonicFrequency:2299775718 realtimeReady:1 realtimeBaseCycles:9349909768717619 realtimeBaseRef:1583173633785446419 realtimeFrequency:2299775288} I0302 18:27:14.535203 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:14.535455 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:14.535580 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:14.535741 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:14.535927 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:14.536072 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:14.536770 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:14.537015 30369 task_signals.go:452] [ 2] Notified of group signal 23 D0302 18:27:14.537174 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:14.537398 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:14.537524 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:14.538132 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:14.538444 30369 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal D0302 18:27:14.785195 30369 parameters.go:238] Clock(Monotonic): error: -436 ns, adjusted frequency from 2299775718 Hz to 2299773680 Hz D0302 18:27:14.785449 30369 parameters.go:238] Clock(Realtime): error: -220 ns, adjusted frequency from 2299775288 Hz to 2299774123 Hz D0302 18:27:14.785694 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349912067873569 monotonicBaseRef:53000270425 monotonicFrequency:2299773680 realtimeReady:1 realtimeBaseCycles:9349912068482701 realtimeBaseRef:1583173634785441981 realtimeFrequency:2299774123} D0302 18:27:15.785172 30369 parameters.go:238] Clock(Monotonic): error: 264 ns, adjusted frequency from 2299773680 Hz to 2299775178 Hz D0302 18:27:15.785365 30369 parameters.go:238] Clock(Realtime): error: -32 ns, adjusted frequency from 2299774123 Hz to 2299774581 Hz D0302 18:27:15.785514 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349914367601205 monotonicBaseRef:54000250403 monotonicFrequency:2299775178 realtimeReady:1 realtimeBaseCycles:9349914368068484 realtimeBaseRef:1583173635785360086 realtimeFrequency:2299774581} D0302 18:27:16.785871 30369 parameters.go:238] Clock(Monotonic): error: -213 ns, adjusted frequency from 2299775178 Hz to 2299774219 Hz D0302 18:27:16.786137 30369 parameters.go:238] Clock(Realtime): error: 305 ns, adjusted frequency from 2299774581 Hz to 2299775412 Hz D0302 18:27:16.786307 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349916668972875 monotonicBaseRef:55000944597 monotonicFrequency:2299774219 realtimeReady:1 realtimeBaseCycles:9349916669613461 realtimeBaseRef:1583173636786129898 realtimeFrequency:2299775412} I0302 18:27:17.502260 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:17.502522 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:17.502668 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:17.502724 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:17.502913 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:17.503028 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:17.785153 30369 parameters.go:238] Clock(Monotonic): error: 247 ns, adjusted frequency from 2299774219 Hz to 2299775233 Hz D0302 18:27:17.785356 30369 parameters.go:238] Clock(Realtime): error: -323 ns, adjusted frequency from 2299775412 Hz to 2299773889 Hz D0302 18:27:17.785517 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349918967087118 monotonicBaseRef:56000222797 monotonicFrequency:2299775233 realtimeReady:1 realtimeBaseCycles:9349918967591049 realtimeBaseRef:1583173637785348159 realtimeFrequency:2299773889} D0302 18:27:18.785208 30369 parameters.go:238] Clock(Monotonic): error: 398 ns, adjusted frequency from 2299775233 Hz to 2299775696 Hz D0302 18:27:18.785394 30369 parameters.go:238] Clock(Realtime): error: -94 ns, adjusted frequency from 2299773889 Hz to 2299774447 Hz D0302 18:27:18.785472 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349921266963502 monotonicBaseRef:57000266779 monotonicFrequency:2299775696 realtimeReady:1 realtimeBaseCycles:9349921267458740 realtimeBaseRef:1583173638785388946 realtimeFrequency:2299774447} D0302 18:27:19.785175 30369 parameters.go:238] Clock(Monotonic): error: -327 ns, adjusted frequency from 2299775696 Hz to 2299773935 Hz D0302 18:27:19.785436 30369 parameters.go:238] Clock(Realtime): error: 24 ns, adjusted frequency from 2299774447 Hz to 2299774757 Hz D0302 18:27:19.785626 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349923566703283 monotonicBaseRef:58000251162 monotonicFrequency:2299773935 realtimeReady:1 realtimeBaseCycles:9349923567321432 realtimeBaseRef:1583173639785427317 realtimeFrequency:2299774757} D0302 18:27:20.785179 30369 parameters.go:238] Clock(Monotonic): error: -256 ns, adjusted frequency from 2299773935 Hz to 2299774047 Hz D0302 18:27:20.785456 30369 parameters.go:238] Clock(Realtime): error: -46 ns, adjusted frequency from 2299774757 Hz to 2299774528 Hz D0302 18:27:20.785615 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349925866488178 monotonicBaseRef:59000255927 monotonicFrequency:2299774047 realtimeReady:1 realtimeBaseCycles:9349925867133686 realtimeBaseRef:1583173640785443621 realtimeFrequency:2299774528} I0302 18:27:21.502492 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:21.502810 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:21.502971 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:21.503069 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:21.503141 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:21.503310 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:21.503352 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:21.503455 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:21.503513 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:21.504028 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:21.504125 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:21.504086 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:21.504562 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 I0302 18:27:21.505408 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:21.505746 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:21.505794 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:21.505948 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:21.506136 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:21.506116 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:21.506270 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:21.506285 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:21.506413 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:21.506429 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:21.506749 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:21.506880 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0302 18:27:21.507197 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:21.507243 30369 task_block.go:223] [ 3] Interrupt queued D0302 18:27:21.507212 30369 task_block.go:223] [ 3] Interrupt queued D0302 18:27:21.507445 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:21.507697 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:21.508765 30369 task_signals.go:179] [ 3] Restarting syscall 202 after errno 512: interrupted by signal 23 I0302 18:27:21.508904 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:21.509005 30369 task_signals.go:220] [ 3] Signal 23: delivering to handler D0302 18:27:21.509113 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:21.509215 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:21.509245 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:21.509419 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:21.509535 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:21.785191 30369 parameters.go:238] Clock(Monotonic): error: 108 ns, adjusted frequency from 2299774047 Hz to 2299774817 Hz D0302 18:27:21.785460 30369 parameters.go:238] Clock(Realtime): error: 131 ns, adjusted frequency from 2299774528 Hz to 2299774960 Hz D0302 18:27:21.785565 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349928166278512 monotonicBaseRef:60000263009 monotonicFrequency:2299774817 realtimeReady:1 realtimeBaseCycles:9349928166929772 realtimeBaseRef:1583173641785452994 realtimeFrequency:2299774960} D0302 18:27:22.785615 30369 parameters.go:238] Clock(Monotonic): error: -147 ns, adjusted frequency from 2299774817 Hz to 2299774300 Hz D0302 18:27:22.785806 30369 parameters.go:238] Clock(Realtime): error: 53 ns, adjusted frequency from 2299774960 Hz to 2299774824 Hz D0302 18:27:22.785967 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349930467044953 monotonicBaseRef:61000694192 monotonicFrequency:2299774300 realtimeReady:1 realtimeBaseCycles:9349930467504294 realtimeBaseRef:1583173642785800663 realtimeFrequency:2299774824} I0302 18:27:22.786052 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:22.786274 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:22.786384 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:22.786566 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:22.786545 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:22.786681 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:22.786824 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:22.786960 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:23.785228 30369 parameters.go:238] Clock(Monotonic): error: -159 ns, adjusted frequency from 2299774300 Hz to 2299774276 Hz I0302 18:27:23.785416 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:23.785534 30369 parameters.go:238] Clock(Realtime): error: 13 ns, adjusted frequency from 2299774824 Hz to 2299774701 Hz D0302 18:27:23.785631 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:23.785756 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:23.785708 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349932765919750 monotonicBaseRef:62000303065 monotonicFrequency:2299774276 realtimeReady:1 realtimeBaseCycles:9349932766633287 realtimeBaseRef:1583173643785519839 realtimeFrequency:2299774701} D0302 18:27:23.785790 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:23.786068 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:23.786220 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:24.785266 30369 parameters.go:238] Clock(Monotonic): error: -79 ns, adjusted frequency from 2299774276 Hz to 2299774570 Hz I0302 18:27:24.785354 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:24.785457 30369 parameters.go:238] Clock(Realtime): error: -223 ns, adjusted frequency from 2299774701 Hz to 2299774161 Hz D0302 18:27:24.785599 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:24.785769 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:24.785732 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:24.786021 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:24.786006 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:24.786179 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:24.786170 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:24.786339 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:24.786451 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:24.786563 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:24.786751 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:24.785686 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349935065778700 monotonicBaseRef:63000339883 monotonicFrequency:2299774570 realtimeReady:1 realtimeBaseCycles:9349935066250393 realtimeBaseRef:1583173644785451312 realtimeFrequency:2299774161} D0302 18:27:24.786894 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:24.786980 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:24.787169 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:24.787293 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:25.785212 30369 parameters.go:238] Clock(Monotonic): error: 77 ns, adjusted frequency from 2299774570 Hz to 2299774833 Hz D0302 18:27:25.785469 30369 parameters.go:238] Clock(Realtime): error: 274 ns, adjusted frequency from 2299774161 Hz to 2299775196 Hz D0302 18:27:25.785615 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349937365427062 monotonicBaseRef:64000285004 monotonicFrequency:2299774833 realtimeReady:1 realtimeBaseCycles:9349937366048199 realtimeBaseRef:1583173645785461593 realtimeFrequency:2299775196} D0302 18:27:26.785128 30369 parameters.go:238] Clock(Monotonic): error: -141 ns, adjusted frequency from 2299774833 Hz to 2299774388 Hz D0302 18:27:26.785376 30369 parameters.go:238] Clock(Realtime): error: 114 ns, adjusted frequency from 2299775196 Hz to 2299774939 Hz D0302 18:27:26.785495 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349939665017355 monotonicBaseRef:65000204761 monotonicFrequency:2299774388 realtimeReady:1 realtimeBaseCycles:9349939665612221 realtimeBaseRef:1583173646785369769 realtimeFrequency:2299774939} D0302 18:27:27.785183 30369 parameters.go:238] Clock(Monotonic): error: -6 ns, adjusted frequency from 2299774388 Hz to 2299774643 Hz D0302 18:27:27.785414 30369 parameters.go:238] Clock(Realtime): error: -289 ns, adjusted frequency from 2299774939 Hz to 2299773986 Hz D0302 18:27:27.785530 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349941964899988 monotonicBaseRef:66000251828 monotonicFrequency:2299774643 realtimeReady:1 realtimeBaseCycles:9349941965472368 realtimeBaseRef:1583173647785406819 realtimeFrequency:2299773986} I0302 18:27:28.502346 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:28.502563 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:28.502663 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:28.502758 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:28.502961 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:28.503126 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:28.785214 30369 parameters.go:238] Clock(Monotonic): error: 276 ns, adjusted frequency from 2299774643 Hz to 2299775240 Hz D0302 18:27:28.785433 30369 parameters.go:238] Clock(Realtime): error: 44 ns, adjusted frequency from 2299773986 Hz to 2299774683 Hz D0302 18:27:28.785540 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349944264768144 monotonicBaseRef:67000292489 monotonicFrequency:2299775240 realtimeReady:1 realtimeBaseCycles:9349944265291000 realtimeBaseRef:1583173648785426232 realtimeFrequency:2299774683} I0302 18:27:28.785978 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:28.786271 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:28.786524 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:28.786674 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:28.786951 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:28.787097 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:28.790535 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:28.790626 30369 urpc.go:577] urpc: unmarshal success. D0302 18:27:28.790720 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:28.790854 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:28.790918 30369 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0302 18:27:28.790977 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:28.791197 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:28.791332 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:28.791281 30369 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 18:27:29.786059 30369 parameters.go:238] Clock(Monotonic): error: 153 ns, adjusted frequency from 2299775240 Hz to 2299775025 Hz D0302 18:27:29.786249 30369 parameters.go:238] Clock(Realtime): error: -34 ns, adjusted frequency from 2299774683 Hz to 2299774613 Hz D0302 18:27:29.786378 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349946566480471 monotonicBaseRef:68001134783 monotonicFrequency:2299775025 realtimeReady:1 realtimeBaseCycles:9349946566943977 realtimeBaseRef:1583173649786242961 realtimeFrequency:2299774613} D0302 18:27:30.785221 30369 parameters.go:238] Clock(Monotonic): error: 220 ns, adjusted frequency from 2299775025 Hz to 2299775173 Hz D0302 18:27:30.785579 30369 parameters.go:238] Clock(Realtime): error: 23 ns, adjusted frequency from 2299774613 Hz to 2299774788 Hz D0302 18:27:30.785778 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349948864324700 monotonicBaseRef:69000295224 monotonicFrequency:2299775173 realtimeReady:1 realtimeBaseCycles:9349948865156360 realtimeBaseRef:1583173650785563663 realtimeFrequency:2299774788} I0302 18:27:31.502468 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:31.502735 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:31.503065 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:31.502936 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:31.503824 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:31.503965 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:31.503905 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:31.504047 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:31.504120 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:31.504611 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:31.504749 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:31.504725 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:31.505247 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:31.505394 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:31.505408 30369 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0302 18:27:31.515332 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:31.515655 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:31.515800 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:31.515925 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:31.516218 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:31.516380 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:31.785362 30369 parameters.go:238] Clock(Monotonic): error: -458 ns, adjusted frequency from 2299775173 Hz to 2299773688 Hz D0302 18:27:31.785604 30369 parameters.go:238] Clock(Realtime): error: 189 ns, adjusted frequency from 2299774788 Hz to 2299775004 Hz D0302 18:27:31.785797 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349951164424581 monotonicBaseRef:70000436415 monotonicFrequency:2299773688 realtimeReady:1 realtimeBaseCycles:9349951164995919 realtimeBaseRef:1583173651785591827 realtimeFrequency:2299775004} D0302 18:27:32.785490 30369 parameters.go:238] Clock(Monotonic): error: 33 ns, adjusted frequency from 2299773688 Hz to 2299774761 Hz D0302 18:27:32.785761 30369 parameters.go:238] Clock(Realtime): error: -107 ns, adjusted frequency from 2299775004 Hz to 2299774410 Hz D0302 18:27:32.785927 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349953464485573 monotonicBaseRef:71000561342 monotonicFrequency:2299774761 realtimeReady:1 realtimeBaseCycles:9349953465143755 realtimeBaseRef:1583173652785753943 realtimeFrequency:2299774410} D0302 18:27:33.786182 30369 parameters.go:238] Clock(Monotonic): error: 219 ns, adjusted frequency from 2299774761 Hz to 2299775115 Hz D0302 18:27:33.786422 30369 parameters.go:238] Clock(Realtime): error: -68 ns, adjusted frequency from 2299774410 Hz to 2299774493 Hz I0302 18:27:33.786430 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:33.786660 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:33.786572 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349955765855607 monotonicBaseRef:72001255006 monotonicFrequency:2299775115 realtimeReady:1 realtimeBaseCycles:9349955766439404 realtimeBaseRef:1583173653786415416 realtimeFrequency:2299774493} D0302 18:27:33.786768 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:33.786813 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:33.786899 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:33.786999 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:33.787113 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:33.787225 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:34.785209 30369 parameters.go:238] Clock(Monotonic): error: -68 ns, adjusted frequency from 2299775115 Hz to 2299774423 Hz D0302 18:27:34.785453 30369 parameters.go:238] Clock(Realtime): error: 88 ns, adjusted frequency from 2299774493 Hz to 2299774896 Hz D0302 18:27:34.785583 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349958063400367 monotonicBaseRef:73000285191 monotonicFrequency:2299774423 realtimeReady:1 realtimeBaseCycles:9349958063984620 realtimeBaseRef:1583173654785446070 realtimeFrequency:2299774896} D0302 18:27:35.785180 30369 parameters.go:238] Clock(Monotonic): error: 56 ns, adjusted frequency from 2299774423 Hz to 2299774792 Hz D0302 18:27:35.785474 30369 parameters.go:238] Clock(Realtime): error: -1 ns, adjusted frequency from 2299774896 Hz to 2299774654 Hz D0302 18:27:35.785665 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349960363103473 monotonicBaseRef:74000254180 monotonicFrequency:2299774792 realtimeReady:1 realtimeBaseCycles:9349960363809299 realtimeBaseRef:1583173655785467716 realtimeFrequency:2299774654} I0302 18:27:36.502501 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:36.502761 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:36.502869 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:36.502958 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:36.503027 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:36.503174 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:36.503374 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:36.503573 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:36.785735 30369 parameters.go:238] Clock(Monotonic): error: 184 ns, adjusted frequency from 2299774792 Hz to 2299775012 Hz D0302 18:27:36.786012 30369 parameters.go:238] Clock(Realtime): error: -82 ns, adjusted frequency from 2299774654 Hz to 2299774453 Hz D0302 18:27:36.786139 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349962664148387 monotonicBaseRef:75000806461 monotonicFrequency:2299775012 realtimeReady:1 realtimeBaseCycles:9349962664819388 realtimeBaseRef:1583173656786004914 realtimeFrequency:2299774453} D0302 18:27:37.785131 30369 parameters.go:238] Clock(Monotonic): error: -282 ns, adjusted frequency from 2299775012 Hz to 2299773992 Hz D0302 18:27:37.785385 30369 parameters.go:238] Clock(Realtime): error: 84 ns, adjusted frequency from 2299774453 Hz to 2299774847 Hz D0302 18:27:37.785525 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349964962444367 monotonicBaseRef:76000163340 monotonicFrequency:2299773992 realtimeReady:1 realtimeBaseCycles:9349964963148822 realtimeBaseRef:1583173657785376583 realtimeFrequency:2299774847} D0302 18:27:38.785227 30369 parameters.go:238] Clock(Monotonic): error: -14 ns, adjusted frequency from 2299773992 Hz to 2299774608 Hz D0302 18:27:38.785495 30369 parameters.go:238] Clock(Realtime): error: -14 ns, adjusted frequency from 2299774847 Hz to 2299774607 Hz I0302 18:27:38.785405 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:38.785594 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349967262536915 monotonicBaseRef:77000301856 monotonicFrequency:2299774608 realtimeReady:1 realtimeBaseCycles:9349967263181622 realtimeBaseRef:1583173658785488747 realtimeFrequency:2299774607} D0302 18:27:38.785766 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:38.785973 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:38.786159 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:38.786311 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:38.786470 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:38.786743 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:38.786870 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:39.785183 30369 parameters.go:238] Clock(Monotonic): error: -242 ns, adjusted frequency from 2299774608 Hz to 2299774166 Hz I0302 18:27:39.785357 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:39.785432 30369 parameters.go:238] Clock(Realtime): error: -111 ns, adjusted frequency from 2299774607 Hz to 2299774337 Hz D0302 18:27:39.785587 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:39.785570 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349969562203783 monotonicBaseRef:78000255007 monotonicFrequency:2299774166 realtimeReady:1 realtimeBaseCycles:9349969562809780 realtimeBaseRef:1583173659785425067 realtimeFrequency:2299774337} D0302 18:27:39.785747 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:39.785868 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:39.785996 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:39.786143 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:39.786377 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:39.786489 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:40.502815 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:40.503077 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:40.503236 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:40.503415 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:40.503571 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:40.503731 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:40.503859 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:40.504089 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:40.504178 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:40.504386 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:40.504510 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:40.504484 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:40.504686 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:40.504864 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:40.785214 30369 parameters.go:238] Clock(Monotonic): error: 515 ns, adjusted frequency from 2299774166 Hz to 2299775748 Hz D0302 18:27:40.785440 30369 parameters.go:238] Clock(Realtime): error: 165 ns, adjusted frequency from 2299774337 Hz to 2299775082 Hz D0302 18:27:40.785570 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349971862049802 monotonicBaseRef:79000286250 monotonicFrequency:2299775748 realtimeReady:1 realtimeBaseCycles:9349971862604884 realtimeBaseRef:1583173660785434097 realtimeFrequency:2299775082} D0302 18:27:41.785223 30369 parameters.go:238] Clock(Monotonic): error: -207 ns, adjusted frequency from 2299775748 Hz to 2299774069 Hz I0302 18:27:41.785334 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:41.785462 30369 parameters.go:238] Clock(Realtime): error: -163 ns, adjusted frequency from 2299775082 Hz to 2299774267 Hz D0302 18:27:41.785600 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:41.785602 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349974161849539 monotonicBaseRef:80000296681 monotonicFrequency:2299774069 realtimeReady:1 realtimeBaseCycles:9349974162400954 realtimeBaseRef:1583173661785443223 realtimeFrequency:2299774267} D0302 18:27:41.785805 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:41.785941 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:41.786070 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:41.786221 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:41.786187 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:41.786298 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:41.786314 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:41.786807 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:41.786910 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:41.786973 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:41.787181 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:41.787303 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:42.785364 30369 parameters.go:238] Clock(Monotonic): error: 75 ns, adjusted frequency from 2299774069 Hz to 2299774781 Hz D0302 18:27:42.785608 30369 parameters.go:238] Clock(Realtime): error: -87 ns, adjusted frequency from 2299774267 Hz to 2299774484 Hz D0302 18:27:42.785769 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349976461951295 monotonicBaseRef:81000439167 monotonicFrequency:2299774781 realtimeReady:1 realtimeBaseCycles:9349976462540093 realtimeBaseRef:1583173662785601878 realtimeFrequency:2299774484} I0302 18:27:42.786779 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:42.787000 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:42.787182 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:42.787350 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:42.787723 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:42.787846 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:43.502556 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:43.502816 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:43.502952 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:43.503023 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:43.503286 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:43.503456 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:43.785225 30369 parameters.go:238] Clock(Monotonic): error: -102 ns, adjusted frequency from 2299774781 Hz to 2299774403 Hz D0302 18:27:43.785433 30369 parameters.go:238] Clock(Realtime): error: 170 ns, adjusted frequency from 2299774484 Hz to 2299775076 Hz I0302 18:27:43.785330 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:43.785592 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349978761405350 monotonicBaseRef:82000299707 monotonicFrequency:2299774403 realtimeReady:1 realtimeBaseCycles:9349978761913009 realtimeBaseRef:1583173663785427266 realtimeFrequency:2299775076} D0302 18:27:43.785758 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:43.785903 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:43.785945 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:43.786074 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:43.786173 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:43.786206 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:43.786300 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:43.786381 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:43.786707 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:43.786806 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:43.786912 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:43.787161 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:43.787308 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 18:27:44.502491 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:44.502763 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:44.502927 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:44.503059 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:44.503276 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:44.503416 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:44.535726 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:44.536013 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:44.536149 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:44.536294 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:44.536536 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:44.536659 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:44.785162 30369 parameters.go:238] Clock(Monotonic): error: 58 ns, adjusted frequency from 2299774403 Hz to 2299774724 Hz D0302 18:27:44.785366 30369 parameters.go:238] Clock(Realtime): error: -182 ns, adjusted frequency from 2299775076 Hz to 2299774203 Hz D0302 18:27:44.785570 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349981061046297 monotonicBaseRef:83000241676 monotonicFrequency:2299774724 realtimeReady:1 realtimeBaseCycles:9349981061537400 realtimeBaseRef:1583173664785361744 realtimeFrequency:2299774203} I0302 18:27:45.502892 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:45.503139 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:45.503269 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:45.503278 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:45.503490 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:45.503664 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:45.503426 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:45.504064 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:45.504164 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:45.504347 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:45.504439 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:45.504445 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:45.504713 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:45.504894 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:45.785096 30369 parameters.go:238] Clock(Monotonic): error: 154 ns, adjusted frequency from 2299774724 Hz to 2299775004 Hz D0302 18:27:45.785306 30369 parameters.go:238] Clock(Realtime): error: -154 ns, adjusted frequency from 2299774203 Hz to 2299774357 Hz D0302 18:27:45.785465 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349983360659282 monotonicBaseRef:84000171347 monotonicFrequency:2299775004 realtimeReady:1 realtimeBaseCycles:9349983361169756 realtimeBaseRef:1583173665785300065 realtimeFrequency:2299774357} I0302 18:27:46.502329 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:46.502527 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:46.502669 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:46.502803 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:46.502881 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:46.502962 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:46.503174 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:46.503312 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:46.785599 30369 parameters.go:238] Clock(Monotonic): error: -34 ns, adjusted frequency from 2299775004 Hz to 2299774605 Hz D0302 18:27:46.785845 30369 parameters.go:238] Clock(Realtime): error: 32 ns, adjusted frequency from 2299774357 Hz to 2299774802 Hz D0302 18:27:46.785957 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349985661580224 monotonicBaseRef:85000669629 monotonicFrequency:2299774605 realtimeReady:1 realtimeBaseCycles:9349985662181866 realtimeBaseRef:1583173666785838271 realtimeFrequency:2299774802} I0302 18:27:47.502449 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:47.502724 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:47.502860 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:47.502893 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:47.503067 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:47.503100 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:47.503239 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:47.503236 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:47.503376 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:47.503655 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:47.503760 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:47.504057 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:47.504184 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:47.504365 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:47.504501 30369 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0302 18:27:47.515296 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:47.515530 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:47.515632 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:47.515697 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:47.515796 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:47.515916 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:47.516067 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:47.516211 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:47.785172 30369 parameters.go:238] Clock(Monotonic): error: -23 ns, adjusted frequency from 2299774605 Hz to 2299774616 Hz D0302 18:27:47.785403 30369 parameters.go:238] Clock(Realtime): error: 173 ns, adjusted frequency from 2299774802 Hz to 2299775087 Hz D0302 18:27:47.785507 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349987960379004 monotonicBaseRef:86000245315 monotonicFrequency:2299774616 realtimeReady:1 realtimeBaseCycles:9349987960938939 realtimeBaseRef:1583173667785395736 realtimeFrequency:2299775087} D0302 18:27:48.785331 30369 parameters.go:238] Clock(Monotonic): error: 329 ns, adjusted frequency from 2299774616 Hz to 2299775367 Hz D0302 18:27:48.785611 30369 parameters.go:238] Clock(Realtime): error: 219 ns, adjusted frequency from 2299775087 Hz to 2299775119 Hz I0302 18:27:48.785550 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:48.785905 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:48.785819 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349990260518271 monotonicBaseRef:87000403874 monotonicFrequency:2299775367 realtimeReady:1 realtimeBaseCycles:9349990261188216 realtimeBaseRef:1583173668785601925 realtimeFrequency:2299775119} D0302 18:27:48.786025 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:48.786120 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:48.786288 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:48.786382 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:48.786486 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:48.786562 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:48.786637 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:48.788879 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:48.788826 30369 task_block.go:223] [ 2] Interrupt queued I0302 18:27:48.789102 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:48.790642 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:48.790875 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:48.790913 30369 task_signals.go:452] [ 2] Notified of group signal 23 D0302 18:27:48.791024 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:48.791077 30369 task_block.go:223] [ 2] Interrupt queued I0302 18:27:48.791220 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:48.791239 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:48.791455 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:48.791548 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:48.791710 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:48.791931 30369 task_block.go:223] [ 3] Interrupt queued D0302 18:27:48.792024 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:48.792033 30369 task_block.go:223] [ 3] Interrupt queued D0302 18:27:48.792226 30369 task_block.go:223] [ 4] Interrupt queued D0302 18:27:48.792251 30369 task_block.go:223] [ 4] Interrupt queued D0302 18:27:48.792374 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:48.792507 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:48.792664 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:48.792819 30369 task_run.go:155] [ 3] Restarting syscall 202 after errno 512: not interrupted by handled signal D0302 18:27:48.792845 30369 task_run.go:155] [ 4] Restarting syscall 202 after errno 512: not interrupted by handled signal I0302 18:27:49.052932 33258 main.go:305] *************************** I0302 18:27:49.053100 33258 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 /syzkaller175335520] I0302 18:27:49.053643 33258 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0302 18:27:49.053753 33258 main.go:308] PID: 33258 I0302 18:27:49.053834 33258 main.go:309] UID: 0, GID: 0 I0302 18:27:49.053930 33258 main.go:310] Configuration: I0302 18:27:49.054029 33258 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0302 18:27:49.054143 33258 main.go:312] Platform: ptrace I0302 18:27:49.054244 33258 main.go:313] FileAccess: shared, overlay: false I0302 18:27:49.054355 33258 main.go:314] Network: sandbox, logging: false I0302 18:27:49.054445 33258 main.go:315] Strace: false, max size: 1024, syscalls: [] I0302 18:27:49.054538 33258 main.go:316] *************************** W0302 18:27:49.054602 33258 main.go:321] Block the TERM signal. This is only safe in tests! D0302 18:27:49.055045 33258 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.062328 33258 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0302 18:27:49.062503 33258 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.062626 33258 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.063133 33258 urpc.go:534] urpc: successfully marshalled 117 bytes. D0302 18:27:49.063518 30369 urpc.go:577] urpc: unmarshal success. D0302 18:27:49.063823 30369 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0302 18:27:49.064191 30369 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 18:27:49.064437 33258 urpc.go:577] urpc: unmarshal success. D0302 18:27:49.064615 33258 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 /syzkaller175335520 D0302 18:27:49.064728 33258 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0302 18:27:49.064914 33258 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 /syzkaller175335520 D0302 18:27:49.065104 33258 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-0" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.065274 33258 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.066229 33258 urpc.go:534] urpc: successfully marshalled 634 bytes. D0302 18:27:49.066657 30369 urpc.go:577] urpc: unmarshal success. D0302 18:27:49.069604 30369 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 /syzkaller175335520 D0302 18:27:49.069851 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0302 18:27:49.070631 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.070873 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 18:27:49.071539 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} I0302 18:27:49.072163 30369 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 /syzkaller175335520] D0302 18:27:49.073318 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0302 18:27:49.074618 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] 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: 1583173584, NanoSec: 666382964}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 18350334}]} D0302 18:27:49.074957 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0302 18:27:49.075440 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.075787 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 18:27:49.076868 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 18350334}, 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: 1583173584, NanoSec: 666382964}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0302 18:27:49.077041 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalk{FID: 5, NewFID: 6, Names: []} D0302 18:27:49.079833 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rwalk{QIDs: []} I0302 18:27:49.080008 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.080072 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tlopen{FID: 6, Flags: ReadOnly} D0302 18:27:49.089373 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlopen{QID: QID{Type: 0, Version: 0, Path: 18350334}, IoUnit: 0, File: &{{36}}} D0302 18:27:49.095589 30369 syscalls.go:266] Allocating stack with size of 8388608 bytes D0302 18:27:49.097327 30369 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-0 0}:0xc00000e780 {ci-gvisor-ptrace-proxy-sandbox-race-0 23}:0xc0005752a0] D0302 18:27:49.097983 33258 urpc.go:577] urpc: unmarshal success. D0302 18:27:49.098150 33258 container.go:580] Wait on PID 23 in container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.097682 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.097736 30369 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 18:27:49.097848 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.098068 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.098220 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:49.098355 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.098344 33258 sandbox.go:761] Waiting for PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.098504 33258 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:49.098531 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.098695 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.099304 33258 urpc.go:534] urpc: successfully marshalled 100 bytes. D0302 18:27:49.099555 30369 urpc.go:577] urpc: unmarshal success. D0302 18:27:49.099931 30369 controller.go:443] containerManager.Wait D0302 18:27:49.107147 30369 task_block.go:223] [ 23] Interrupt queued I0302 18:27:49.135273 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.135515 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.135707 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.135962 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.136174 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.136310 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.165342 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.165593 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.165744 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.165905 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.166004 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:49.166139 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.166289 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.166433 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.215272 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.215517 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.215648 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.215693 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.215941 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.216075 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.235252 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.235512 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.235672 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.235836 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.236138 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.236326 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.285345 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.285604 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.285721 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.285876 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.285835 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.285984 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:49.286087 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.286195 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.296918 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.297174 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.297327 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.297414 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.297640 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.297823 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.316193 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.316378 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.316502 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.316653 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.316807 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.316911 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.341847 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.342019 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.342155 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.342285 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.342396 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.342494 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.358396 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.358580 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.358700 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.358877 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.359002 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.359110 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.360209 30369 task_block.go:223] [ 24] Interrupt queued D0302 18:27:49.361619 30369 task_block.go:223] [ 25] Interrupt queued D0302 18:27:49.374039 30369 task_block.go:223] [ 26] Interrupt queued D0302 18:27:49.374724 30369 task_block.go:223] [ 27] Interrupt queued I0302 18:27:49.409593 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.409870 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.410012 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.410065 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.410319 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.410456 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.419657 30369 task_block.go:223] [ 28] Interrupt queued D0302 18:27:49.427906 30369 task_block.go:223] [ 29] Interrupt queued D0302 18:27:49.482856 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0302 18:27:49.483504 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.483684 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 18:27:49.485326 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} I0302 18:27:49.492614 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.492891 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.493041 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.493087 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.493285 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.493392 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.515562 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.515919 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.516113 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.516272 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.516504 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.516672 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.528567 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.528808 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.529204 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.529281 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.528439 30369 urpc.go:577] urpc: unmarshal success. D0302 18:27:49.529583 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.529632 30369 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} I0302 18:27:49.529596 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.529744 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.529946 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.530019 30369 urpc.go:534] urpc: successfully marshalled 37 bytes. D0302 18:27:49.530076 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.530298 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.530406 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:49.530543 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.530562 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:49.530731 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:49.530983 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:49.531179 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler I0302 18:27:49.534147 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.534391 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.534616 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.534773 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.534914 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:49.535091 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.535246 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.535388 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.542990 30369 task_block.go:223] [ 30] Interrupt queued D0302 18:27:49.552682 30369 task_block.go:223] [ 31] Interrupt queued D0302 18:27:49.577570 30369 task_block.go:223] [ 32] Interrupt queued D0302 18:27:49.580999 30369 task_block.go:223] [ 33] Interrupt queued D0302 18:27:49.587596 30369 task_block.go:223] [ 34] Interrupt queued I0302 18:27:49.608042 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.608314 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.608443 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.608587 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.608794 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.608944 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.621225 30369 task_block.go:223] [ 35] Interrupt queued D0302 18:27:49.630074 30369 task_block.go:223] [ 36] Interrupt queued I0302 18:27:49.658299 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.658543 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.658637 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.658766 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.658952 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.659052 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.660253 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.660410 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.660567 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.660724 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.660859 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:49.660908 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.661213 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.661398 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.676987 30369 task_block.go:223] [ 37] Interrupt queued D0302 18:27:49.682419 30369 task_block.go:223] [ 38] Interrupt queued D0302 18:27:49.684284 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller175335520]} D0302 18:27:49.686522 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] 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: 421, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583173669, NanoSec: 14646945}, MTime: {Sec: 1583173669, NanoSec: 14646945}, CTime: {Sec: 1583173669, NanoSec: 14646945}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 18350326}]} D0302 18:27:49.686937 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller175335520, Size: 1} D0302 18:27:49.688640 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.689119 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 18:27:49.690395 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 18350326}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 421, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583173669, NanoSec: 14646945}, MTime: {Sec: 1583173669, NanoSec: 14646945}, CTime: {Sec: 1583173669, NanoSec: 14646945}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} I0302 18:27:49.690517 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.690649 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalk{FID: 7, NewFID: 8, Names: []} D0302 18:27:49.690727 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.690975 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.691128 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.691429 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.691607 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rwalk{QIDs: []} D0302 18:27:49.691650 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.691799 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tlopen{FID: 8, Flags: ReadOnly} D0302 18:27:49.692869 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlopen{QID: QID{Type: 0, Version: 0, Path: 18350326}, IoUnit: 0, File: &{{30}}} D0302 18:27:49.699535 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 18:27:49.700841 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 18350326}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 421, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583173669, NanoSec: 14646945}, MTime: {Sec: 1583173669, NanoSec: 14646945}, CTime: {Sec: 1583173669, NanoSec: 14646945}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/02 18:27:49 parsed 1 programs I0302 18:27:49.723958 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.724137 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.724278 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.724329 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.724569 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.724785 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.727632 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.728006 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.728171 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.728237 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.728579 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.729752 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.729856 30369 task_stop.go:118] [ 35] Entering internal stop (*kernel.vforkStop)(nil) D0302 18:27:49.729896 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.729957 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.730015 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.730173 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.730282 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:49.730608 30369 task_block.go:223] [ 39] Interrupt queued D0302 18:27:49.730888 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:49.730984 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:49.731110 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.731467 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:49.731655 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:49.736191 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0302 18:27:49.737649 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] 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: 1583173584, NanoSec: 674383748}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 18350335}]} D0302 18:27:49.737916 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0302 18:27:49.738516 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.739060 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 18:27:49.740551 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 18350335}, 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: 1583173584, NanoSec: 674383748}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0302 18:27:49.740878 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalk{FID: 9, NewFID: 10, Names: []} D0302 18:27:49.746276 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rwalk{QIDs: []} D0302 18:27:49.746562 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tlopen{FID: 10, Flags: ReadOnly} D0302 18:27:49.747516 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlopen{QID: QID{Type: 0, Version: 0, Path: 18350335}, IoUnit: 0, File: &{{31}}} D0302 18:27:49.748534 30369 syscalls.go:266] [ 39] Allocating stack with size of 8388608 bytes D0302 18:27:49.749515 30369 task_stop.go:137] [ 35] Leaving internal stop (*kernel.vforkStop)(nil) I0302 18:27:49.750010 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.750219 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.750308 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.750423 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.750660 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.750808 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.781357 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.781666 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.781815 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.781842 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.782156 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.782294 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.785069 30369 parameters.go:238] Clock(Monotonic): error: 137 ns, adjusted frequency from 2299775367 Hz to 2299775042 Hz D0302 18:27:49.785367 30369 parameters.go:238] Clock(Realtime): error: 18 ns, adjusted frequency from 2299775119 Hz to 2299774718 Hz D0302 18:27:49.785693 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349992559706584 monotonicBaseRef:88000148608 monotonicFrequency:2299775042 realtimeReady:1 realtimeBaseCycles:9349992560404697 realtimeBaseRef:1583173669785359015 realtimeFrequency:2299774718} D0302 18:27:49.791936 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0302 18:27:49.794324 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.794486 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 18:27:49.795045 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} I0302 18:27:49.798784 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.798964 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.799105 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.799158 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.799396 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.799545 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.803154 30369 task_exit.go:221] [ 39] Transitioning from exit state TaskExitNone to TaskExitInitiated D0302 18:27:49.804526 30369 task_exit.go:221] [ 39] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0302 18:27:49.804702 30369 task_signals.go:446] [ 23] Notified of signal 17 D0302 18:27:49.804851 30369 task_block.go:223] [ 23] Interrupt queued D0302 18:27:49.804986 30369 task_block.go:223] [ 23] Interrupt queued D0302 18:27:49.805248 30369 task_signals.go:179] [ 23] Restarting syscall 202 after errno 512: interrupted by signal 17 D0302 18:27:49.805401 30369 task_exit.go:221] [ 39] Transitioning from exit state TaskExitZombie to TaskExitDead D0302 18:27:49.805408 30369 task_signals.go:220] [ 23] Signal 17: delivering to handler D0302 18:27:49.807325 30369 task_block.go:223] [ 40] Interrupt queued D0302 18:27:49.813602 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0302 18:27:49.814952 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] 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: 1583173584, NanoSec: 674383748}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 18350335}]} D0302 18:27:49.815103 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tclunk{FID: 11} D0302 18:27:49.815608 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rclunk{} D0302 18:27:49.815973 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 18:27:49.817046 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 18350335}, 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: 1583173584, NanoSec: 674383748}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/02 18:27:49 executed programs: 0 I0302 18:27:49.830016 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.830227 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.830363 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.830405 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.830571 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.830682 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.831081 30369 task_stop.go:118] [ 35] Entering internal stop (*kernel.vforkStop)(nil) D0302 18:27:49.831907 30369 task_block.go:223] [ 41] Interrupt queued D0302 18:27:49.836936 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0302 18:27:49.838190 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] 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: 1583173584, NanoSec: 674383748}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 18350335}]} D0302 18:27:49.838335 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tclunk{FID: 11} D0302 18:27:49.838812 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rclunk{} D0302 18:27:49.839029 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0302 18:27:49.840331 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 18350335}, 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: 1583173584, NanoSec: 674383748}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0302 18:27:49.841601 30369 syscalls.go:266] [ 41] Allocating stack with size of 8388608 bytes D0302 18:27:49.842775 30369 task_stop.go:137] [ 35] Leaving internal stop (*kernel.vforkStop)(nil) D0302 18:27:49.857262 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0302 18:27:49.857957 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.858156 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0302 18:27:49.858739 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} I0302 18:27:49.860279 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.860477 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.860600 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.860651 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.860873 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.861026 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.888573 30369 task_block.go:223] [ 42] Interrupt queued D0302 18:27:49.894943 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.895699 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.896110 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.896805 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.897255 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.897812 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.898365 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.898832 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.899264 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.899685 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.899830 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.900328 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.901082 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} I0302 18:27:49.901042 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.901494 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.901634 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.901791 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.901849 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.902101 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.902150 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.902241 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.902714 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.903051 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.903616 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.903816 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.904342 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.904755 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.905302 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.906291 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.906922 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.907240 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.908811 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.909081 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.909594 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.909980 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.910481 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.910637 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.911073 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:49.911418 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:49.911898 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:49.912071 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:49.912840 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} I0302 18:27:49.921119 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.921402 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.921545 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.921707 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.921927 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.922060 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.929204 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.929486 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.930087 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.929997 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.930467 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0302 18:27:49.930409 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.931704 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.931803 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.931992 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:49.932235 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.932299 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:49.932460 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:49.932479 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.932879 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:49.933000 30369 task_signals.go:452] [ 2] Notified of group signal 23 D0302 18:27:49.933145 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:49.933265 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:49.933437 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.933553 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:49.948102 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:49.948388 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:49.948538 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.948798 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:49.948975 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:49.949128 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:49.955732 30369 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0302 18:27:49.955966 30369 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 0 D0302 18:27:49.956104 30369 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 0 D0302 18:27:49.956231 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.956431 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.957384 30369 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0302 18:27:49.957522 30369 netfilter.go:54] netfilter: convert to binary: found hook 2 at offset 152 D0302 18:27:49.957636 30369 netfilter.go:54] netfilter: convert to binary: found underflow 2 at offset 152 D0302 18:27:49.957733 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.957838 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.958403 30369 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0302 18:27:49.958511 30369 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0302 18:27:49.958644 30369 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0302 18:27:49.958739 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.958823 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.959378 30369 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0302 18:27:49.959500 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0302 18:27:49.960094 30369 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0302 18:27:49.960167 30369 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0302 18:27:49.960276 30369 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0302 18:27:49.960514 30369 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0302 18:27:49.960656 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.960729 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.961409 30369 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0302 18:27:49.961532 30369 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 152 D0302 18:27:49.961607 30369 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 152 D0302 18:27:49.961718 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.961939 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.962646 30369 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0302 18:27:49.962748 30369 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0302 18:27:49.962866 30369 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0302 18:27:49.962968 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.963080 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.963898 30369 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0302 18:27:49.964015 30369 netfilter.go:54] netfilter: convert to binary: found hook 4 at offset 456 D0302 18:27:49.964131 30369 netfilter.go:54] netfilter: convert to binary: found underflow 4 at offset 456 D0302 18:27:49.964238 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.964355 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.965150 30369 netfilter.go:54] netfilter: convert to binary: current offset: 608 D0302 18:27:49.965363 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0302 18:27:49.966194 30369 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0302 18:27:49.966286 30369 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0302 18:27:49.966400 30369 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0302 18:27:49.966484 30369 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0302 18:27:49.966623 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.966725 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.967364 30369 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0302 18:27:49.967521 30369 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 152 D0302 18:27:49.967640 30369 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 152 D0302 18:27:49.967740 30369 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0302 18:27:49.967856 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0302 18:27:49.968707 30369 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0302 18:27:49.968858 30369 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0302 18:27:49.969754 30369 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 I0302 18:27:50.001365 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.001585 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.001721 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.001894 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.002028 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.002159 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.021594 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.021999 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.022186 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.022393 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.022696 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.022896 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.041986 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.042227 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.042354 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.042427 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.042674 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.042825 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.062092 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.062305 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.062411 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.062559 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.062759 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.062934 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.082306 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.082509 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.082611 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.082718 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.082924 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.083101 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.102557 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.102794 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.102973 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.103034 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.103345 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.103499 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.104686 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.104957 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.105351 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.105688 30369 task_block.go:223] [ 2] Interrupt queued I0302 18:27:50.105745 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.105865 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:50.106028 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.107250 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0302 18:27:50.107487 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.107486 30369 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0302 18:27:50.107652 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.107654 30369 task_signals.go:220] [ 2] Signal 23: delivering to handler D0302 18:27:50.107780 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.107965 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.108192 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.108335 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.122728 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.123005 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.123150 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.123318 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.123640 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.123841 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.142928 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.143124 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.143271 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.143576 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.143740 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.143846 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:50.155189 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.156113 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.156257 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.156880 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.157345 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.157979 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.158304 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.158759 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.159098 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.159864 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.160062 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.160542 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.160989 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.161728 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.162730 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.163344 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.163724 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.164499 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.164651 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} I0302 18:27:50.164627 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.165005 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.165160 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.165202 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.165276 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.165694 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.165769 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.165850 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:50.166552 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.166792 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.167410 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.167816 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.168489 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.168704 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.170186 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.170665 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.171390 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.171611 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.172690 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.173143 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.173712 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} D0302 18:27:50.173877 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.174465 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.174806 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0302 18:27:50.175376 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 2} I0302 18:27:50.175349 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.175538 30369 transport_flipcall.go:127] send [channel @0xc0004d8180] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0302 18:27:50.175535 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.175661 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.175710 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.176023 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.176132 30369 transport_flipcall.go:234] recv [channel @0xc0004d8180] Rlerror{Error: 95} D0302 18:27:50.176218 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:50.207305 30369 task_block.go:223] [ 43] Interrupt queued I0302 18:27:50.221544 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.221810 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.221917 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.221972 30369 task_block.go:223] [ 44] Interrupt queued D0302 18:27:50.222077 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.222229 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.222389 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.235034 30369 compat.go:122] Unsupported syscall: setsockopt, regs: amd64: I0302 18:27:50.249442 30369 compat.go:122] Unsupported syscall: setsockopt, regs: amd64: I0302 18:27:50.370693 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.373360 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.373548 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.373683 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:50.373745 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.373895 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:50.374103 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.374295 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.399934 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.400242 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.400395 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.400489 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.400711 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.400857 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.529442 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.529670 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.529836 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.529966 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.530179 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.530318 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.554817 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.555099 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.555313 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.555430 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.555706 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.555901 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.612384 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.612596 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.612746 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.612893 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.613125 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.613334 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.654752 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.655006 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.655147 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.655203 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.655466 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.655604 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.760434 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.760807 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.760954 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.761093 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.761375 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.761516 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:50.791518 30369 parameters.go:238] Clock(Monotonic): error: -665 ns, adjusted frequency from 2299775042 Hz to 2299773222 Hz D0302 18:27:50.792887 30369 parameters.go:238] Clock(Realtime): error: -263 ns, adjusted frequency from 2299774718 Hz to 2299774120 Hz D0302 18:27:50.793066 30369 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:9349994874291194 monotonicBaseRef:89006588180 monotonicFrequency:2299773222 realtimeReady:1 realtimeBaseCycles:9349994877468206 realtimeBaseRef:1583173670792876616 realtimeFrequency:2299774120} I0302 18:27:50.908903 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.909160 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.909313 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.909332 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:50.909476 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.909631 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.909745 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:50.910018 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.910201 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.910419 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:50.910535 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.910453 30369 task_block.go:223] [ 2] Interrupt queued D0302 18:27:50.910921 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.911046 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:50.911407 30369 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0302 18:27:50.920621 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.920850 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.921030 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.921067 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.921682 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.921790 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.932553 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.932751 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.932883 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:50.933027 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.933017 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.933120 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:50.933318 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.933451 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:50.936889 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.937331 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:50.937769 30369 task_block.go:223] [ 1] Interrupt queued I0302 18:27:50.937999 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.938169 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0302 18:27:50.940527 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:50.940602 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:50.940737 30369 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0302 18:27:50.940937 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:50.941118 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler I0302 18:27:51.017794 30369 loader.go:566] Received external signal 23, mode: Process D0302 18:27:51.018009 30369 task_signals.go:446] [ 1] Notified of signal 23 D0302 18:27:51.018114 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:51.018157 30369 task_block.go:223] [ 1] Interrupt queued D0302 18:27:51.018387 30369 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0302 18:27:51.018501 30369 task_signals.go:220] [ 1] Signal 23: delivering to handler D0302 18:27:51.024332 30369 task_block.go:223] [ 45] Interrupt queued D0302 18:27:51.031509 30369 task_block.go:223] [ 46] Interrupt queued D0302 18:27:51.035626 30369 task_block.go:223] [ 47] Interrupt queued ================== WARNING: DATA RACE Write at 0x00c0009b22a0 by goroutine 345: gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).SetSockOpt() pkg/tcpip/transport/tcp/endpoint.go:1503 +0x34e gvisor.dev/gvisor/pkg/sentry/socket/netstack.setSockOptTCP() pkg/sentry/socket/netstack/netstack.go:1735 +0x35d gvisor.dev/gvisor/pkg/sentry/socket/netstack.SetSockOpt() pkg/sentry/socket/netstack/netstack.go:1538 +0x30f gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).SetSockOpt() pkg/sentry/socket/netstack/netstack.go:1527 +0x6a0 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.SetSockOpt() pkg/sentry/syscalls/linux/sys_socket.go:541 +0x2fd DIAGNOSIS: I0302 18:27:51.078854 33406 main.go:305] *************************** I0302 18:27:51.079027 33406 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-0] I0302 18:27:51.079193 33406 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0302 18:27:51.079308 33406 main.go:308] PID: 33406 I0302 18:27:51.079407 33406 main.go:309] UID: 0, GID: 0 I0302 18:27:51.079500 33406 main.go:310] Configuration: I0302 18:27:51.079615 33406 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0302 18:27:51.079698 33406 main.go:312] Platform: ptrace I0302 18:27:51.079769 33406 main.go:313] FileAccess: shared, overlay: false I0302 18:27:51.079866 33406 main.go:314] Network: sandbox, logging: false I0302 18:27:51.079985 33406 main.go:315] Strace: false, max size: 1024, syscalls: [] I0302 18:27:51.080089 33406 main.go:316] *************************** W0302 18:27:51.080203 33406 main.go:321] Block the TERM signal. This is only safe in tests! D0302 18:27:51.080404 33406 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.086801 33406 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0302 18:27:51.089178 33406 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.089306 33406 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.089836 33406 urpc.go:534] urpc: successfully marshalled 117 bytes. I0302 18:27:51.167821 33406 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 30369 I0302 18:27:51.168003 33406 debug.go:131] Retrieving sandbox stacks D0302 18:27:51.168130 33406 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.168222 33406 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0302 18:27:51.168419 33406 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 30369: connection refused retrieving stacks: connecting to control server at PID 30369: connection refused W0302 18:27:51.168837 33406 main.go:338] Failure to execute command, err: 1 Error collecting stacks: failed to run ["/syzkaller/managers/ptrace-proxy-sandbox-race/current/image" "-root" "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "-watchdog-action=panic" "-network=none" "-debug" "-alsologtostderr" "-platform=ptrace" "-file-access=shared" "-network=sandbox" "-TESTONLY-unsafe-nonroot" "debug" "-stacks" "--ps" "ci-gvisor-ptrace-proxy-sandbox-race-0"]: exit status 128 I0302 18:27:51.078854 33406 main.go:305] *************************** I0302 18:27:51.079027 33406 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-0] I0302 18:27:51.079193 33406 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0302 18:27:51.079308 33406 main.go:308] PID: 33406 I0302 18:27:51.079407 33406 main.go:309] UID: 0, GID: 0 I0302 18:27:51.079500 33406 main.go:310] Configuration: I0302 18:27:51.079615 33406 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0302 18:27:51.079698 33406 main.go:312] Platform: ptrace I0302 18:27:51.079769 33406 main.go:313] FileAccess: shared, overlay: false I0302 18:27:51.079866 33406 main.go:314] Network: sandbox, logging: false I0302 18:27:51.079985 33406 main.go:315] Strace: false, max size: 1024, syscalls: [] I0302 18:27:51.080089 33406 main.go:316] *************************** W0302 18:27:51.080203 33406 main.go:321] Block the TERM signal. This is only safe in tests! D0302 18:27:51.080404 33406 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.086801 33406 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0302 18:27:51.089178 33406 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.089306 33406 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.089836 33406 urpc.go:534] urpc: successfully marshalled 117 bytes. I0302 18:27:51.167821 33406 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 30369 I0302 18:27:51.168003 33406 debug.go:131] Retrieving sandbox stacks D0302 18:27:51.168130 33406 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.168222 33406 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0302 18:27:51.168419 33406 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 30369: connection refused retrieving stacks: connecting to control server at PID 30369: connection refused W0302 18:27:51.168837 33406 main.go:338] Failure to execute command, err: 1 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 0x00c0009b22a0 by goroutine 386: gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).initialReceiveWindow() pkg/tcpip/transport/tcp/endpoint.go:952 +0x77 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).protocolMainLoop() pkg/tcpip/transport/tcp/connect.go:1274 +0xf2f Goroutine 345 (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 386 (running) created at: gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).connect() pkg/tcpip/transport/tcp/endpoint.go:2058 +0xf2d gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).Connect() pkg/tcpip/transport/tcp/endpoint.go:1887 +0x8c gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).Connect() pkg/sentry/socket/netstack/netstack.go:698 +0x4c5 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Connect() pkg/sentry/syscalls/linux/sys_socket.go:280 +0x251 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall() pkg/sentry/kernel/task_syscall.go:170 +0x44d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke() pkg/sentry/kernel/task_syscall.go:291 +0xb4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter() pkg/sentry/kernel/task_syscall.go:252 +0x109 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall() pkg/sentry/kernel/task_syscall.go:227 +0x1b3 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute() pkg/sentry/kernel/task_run.go:232 +0x1aaa gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run() pkg/sentry/kernel/task_run.go:92 +0x320 ================== W0302 18:27:51.160347 33258 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 W0302 18:27:51.162009 33258 main.go:338] Failure to execute command, err: 1 W0302 18:27:51.167912 30299 sandbox.go:742] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-0" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D0302 18:27:51.168660 30299 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.168972 30299 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.169127 30299 sandbox.go:1058] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-0" by destroying sandbox D0302 18:27:51.170409 30299 sandbox.go:788] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0302 18:27:51.170572 30299 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 30363 I0302 18:27:51.372896 30299 main.go:329] Exiting with status: 16896