D0229 20:25:30.337918 59450 parameters.go:238] Clock(Monotonic): error: 254 ns, adjusted frequency from 2299774028 Hz to 2299774843 Hz D0229 20:25:30.338276 59450 parameters.go:238] Clock(Realtime): error: 379 ns, adjusted frequency from 2299773943 Hz to 2299775179 Hz D0229 20:25:30.338443 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968829185028827 monotonicBaseRef:2000293156 monotonicFrequency:2299774843 realtimeReady:1 realtimeBaseCycles:8968829185887075 realtimeBaseRef:1583007930338265610 realtimeFrequency:2299775179} D0229 20:25:31.338171 59450 sampler.go:168] Time: Adjusting syscall overhead up to 8000 I0229 20:25:31.338392 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:31.338395 59450 parameters.go:238] Clock(Monotonic): error: 278 ns, adjusted frequency from 2299774843 Hz to 2299775073 Hz D0229 20:25:31.338582 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:31.338617 59450 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0229 20:25:31.338711 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:31.338764 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:31.338750 59450 parameters.go:238] Clock(Realtime): error: 1421 ns, adjusted frequency from 2299775179 Hz to 2299778017 Hz I0229 20:25:31.338911 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:31.339048 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:31.339176 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:31.339043 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968831485923207 monotonicBaseRef:3000779958 monotonicFrequency:2299775073 realtimeReady:1 realtimeBaseCycles:8968831486762657 realtimeBaseRef:1583007931338744092 realtimeFrequency:2299778017} D0229 20:25:31.339264 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:31.339243 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:31.339926 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:31.339852 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:31.340207 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:31.340605 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:25:31.340745 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:25:32.338505 59450 parameters.go:238] Clock(Monotonic): error: 37 ns, adjusted frequency from 2299775073 Hz to 2299774584 Hz D0229 20:25:32.338736 59450 parameters.go:238] Clock(Realtime): error: -971 ns, adjusted frequency from 2299778017 Hz to 2299772156 Hz D0229 20:25:32.338917 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968833785902249 monotonicBaseRef:4000868648 monotonicFrequency:2299774584 realtimeReady:1 realtimeBaseCycles:8968833786502594 realtimeBaseRef:1583007932338727533 realtimeFrequency:2299772156} D0229 20:25:33.337936 59450 parameters.go:238] Clock(Monotonic): error: 62 ns, adjusted frequency from 2299774584 Hz to 2299774565 Hz I0229 20:25:33.338160 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:33.338473 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:33.338351 59450 parameters.go:238] Clock(Realtime): error: 62 ns, adjusted frequency from 2299772156 Hz to 2299774497 Hz D0229 20:25:33.338617 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:33.338883 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:33.338898 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:33.338737 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968836084403686 monotonicBaseRef:5000315051 monotonicFrequency:2299774565 realtimeReady:1 realtimeBaseCycles:8968836085385775 realtimeBaseRef:1583007933338340983 realtimeFrequency:2299774497} D0229 20:25:33.339078 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:33.339254 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:33.339432 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:33.548022 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:33.548315 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:33.548488 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:33.548579 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:33.548706 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:33.548884 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:33.549025 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:33.549187 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:34.337946 59450 parameters.go:238] Clock(Monotonic): error: 167 ns, adjusted frequency from 2299774565 Hz to 2299774870 Hz I0229 20:25:34.338018 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:34.338209 59450 parameters.go:238] Clock(Realtime): error: 37 ns, adjusted frequency from 2299774497 Hz to 2299774549 Hz D0229 20:25:34.338282 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:34.338352 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968838384178267 monotonicBaseRef:6000315057 monotonicFrequency:2299774870 realtimeReady:1 realtimeBaseCycles:8968838384843198 realtimeBaseRef:1583007934338203111 realtimeFrequency:2299774549} D0229 20:25:34.338471 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:34.338534 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:34.338788 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:34.338906 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:35.337883 59450 parameters.go:238] Clock(Monotonic): error: -78 ns, adjusted frequency from 2299774870 Hz to 2299774365 Hz D0229 20:25:35.338106 59450 parameters.go:238] Clock(Realtime): error: 108 ns, adjusted frequency from 2299774549 Hz to 2299774683 Hz D0229 20:25:35.338242 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968840683832528 monotonicBaseRef:7000262613 monotonicFrequency:2299774365 realtimeReady:1 realtimeBaseCycles:8968840684381916 realtimeBaseRef:1583007935338100565 realtimeFrequency:2299774683} I0229 20:25:35.536547 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:35.536791 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:35.536913 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:35.537074 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:35.537076 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:35.537219 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:35.537402 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:35.537559 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:36.337979 59450 parameters.go:238] Clock(Monotonic): error: 444 ns, adjusted frequency from 2299774365 Hz to 2299775450 Hz D0229 20:25:36.338254 59450 parameters.go:238] Clock(Realtime): error: -213 ns, adjusted frequency from 2299774683 Hz to 2299774065 Hz I0229 20:25:36.338024 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:36.338359 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968842983661629 monotonicBaseRef:8000286413 monotonicFrequency:2299775450 realtimeReady:1 realtimeBaseCycles:8968842984493819 realtimeBaseRef:1583007936338247196 realtimeFrequency:2299774065} D0229 20:25:36.338476 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:36.338737 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:36.338683 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:36.338959 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:36.339066 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:37.337919 59450 parameters.go:238] Clock(Monotonic): error: -145 ns, adjusted frequency from 2299775450 Hz to 2299774101 Hz I0229 20:25:37.338059 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:37.338145 59450 parameters.go:238] Clock(Realtime): error: 178 ns, adjusted frequency from 2299774065 Hz to 2299774922 Hz D0229 20:25:37.338256 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:37.338278 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968845283475985 monotonicBaseRef:9000303330 monotonicFrequency:2299774101 realtimeReady:1 realtimeBaseCycles:8968845284019704 realtimeBaseRef:1583007937338139281 realtimeFrequency:2299774922} D0229 20:25:37.338388 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:37.338513 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:37.338861 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:37.339070 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:37.548059 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:37.548426 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:37.548527 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:37.548638 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:37.548708 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:37.548829 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:37.549000 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:37.549229 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:38.337944 59450 parameters.go:238] Clock(Monotonic): error: -42 ns, adjusted frequency from 2299774101 Hz to 2299774540 Hz D0229 20:25:38.338169 59450 parameters.go:238] Clock(Realtime): error: 225 ns, adjusted frequency from 2299774922 Hz to 2299775123 Hz D0229 20:25:38.338288 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968847583304375 monotonicBaseRef:10000326936 monotonicFrequency:2299774540 realtimeReady:1 realtimeBaseCycles:8968847583851517 realtimeBaseRef:1583007938338164018 realtimeFrequency:2299775123} D0229 20:25:39.337876 59450 parameters.go:238] Clock(Monotonic): error: 504 ns, adjusted frequency from 2299774540 Hz to 2299775714 Hz D0229 20:25:39.338122 59450 parameters.go:238] Clock(Realtime): error: 224 ns, adjusted frequency from 2299775123 Hz to 2299775117 Hz D0229 20:25:39.338256 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968849882919945 monotonicBaseRef:11000257811 monotonicFrequency:2299775714 realtimeReady:1 realtimeBaseCycles:8968849883512622 realtimeBaseRef:1583007939338114440 realtimeFrequency:2299775117} I0229 20:25:39.536449 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:39.536666 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:39.536796 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:39.536912 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:39.537111 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:39.537230 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:39.548083 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:39.548366 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:39.548514 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:39.548562 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:39.548780 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:39.548899 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:40.337938 59450 parameters.go:238] Clock(Monotonic): error: -197 ns, adjusted frequency from 2299775714 Hz to 2299774042 Hz D0229 20:25:40.338172 59450 parameters.go:238] Clock(Realtime): error: -291 ns, adjusted frequency from 2299775117 Hz to 2299773756 Hz I0229 20:25:40.338193 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:40.338267 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968852182845557 monotonicBaseRef:12000322990 monotonicFrequency:2299774042 realtimeReady:1 realtimeBaseCycles:8968852183406315 realtimeBaseRef:1583007940338165999 realtimeFrequency:2299773756} D0229 20:25:40.338409 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:40.338547 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:40.338691 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:40.338813 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:40.338686 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:40.339056 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:40.339162 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:41.338030 59450 parameters.go:238] Clock(Monotonic): error: 7 ns, adjusted frequency from 2299774042 Hz to 2299774644 Hz I0229 20:25:41.338167 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:41.338278 59450 parameters.go:238] Clock(Realtime): error: -132 ns, adjusted frequency from 2299773756 Hz to 2299774365 Hz D0229 20:25:41.338447 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:41.338430 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968854482706105 monotonicBaseRef:13000360604 monotonicFrequency:2299774644 realtimeReady:1 realtimeBaseCycles:8968854483423329 realtimeBaseRef:1583007941338271773 realtimeFrequency:2299774365} D0229 20:25:41.338608 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:41.338716 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:41.339077 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:41.339352 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:41.536535 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:41.536799 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:41.536987 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:41.537148 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:41.537359 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:41.537495 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:41.548045 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:41.548304 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:41.548436 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:41.548480 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:41.548642 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:41.548696 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:41.548750 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:41.548867 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:41.548852 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:41.549448 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:41.549593 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:41.549653 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:41.549855 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:25:41.550015 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:25:42.338589 59450 parameters.go:238] Clock(Monotonic): error: -294 ns, adjusted frequency from 2299774644 Hz to 2299773997 Hz D0229 20:25:42.338834 59450 parameters.go:238] Clock(Realtime): error: 301 ns, adjusted frequency from 2299774365 Hz to 2299775350 Hz D0229 20:25:42.338982 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968856783884960 monotonicBaseRef:14000971190 monotonicFrequency:2299773997 realtimeReady:1 realtimeBaseCycles:8968856784476819 realtimeBaseRef:1583007942338827968 realtimeFrequency:2299775350} D0229 20:25:43.337960 59450 parameters.go:238] Clock(Monotonic): error: 80 ns, adjusted frequency from 2299773997 Hz to 2299774852 Hz D0229 20:25:43.338221 59450 parameters.go:238] Clock(Realtime): error: 2 ns, adjusted frequency from 2299775350 Hz to 2299774602 Hz D0229 20:25:43.338384 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968859082210713 monotonicBaseRef:15000341456 monotonicFrequency:2299774852 realtimeReady:1 realtimeBaseCycles:8968859082792082 realtimeBaseRef:1583007943338193085 realtimeFrequency:2299774602} D0229 20:25:44.337929 59450 parameters.go:238] Clock(Monotonic): error: 194 ns, adjusted frequency from 2299774852 Hz to 2299774950 Hz D0229 20:25:44.338109 59450 parameters.go:238] Clock(Realtime): error: -332 ns, adjusted frequency from 2299774602 Hz to 2299773949 Hz D0229 20:25:44.338229 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968861381846592 monotonicBaseRef:16000281027 monotonicFrequency:2299774950 realtimeReady:1 realtimeBaseCycles:8968861382359106 realtimeBaseRef:1583007944338102824 realtimeFrequency:2299773949} D0229 20:25:45.337964 59450 parameters.go:238] Clock(Monotonic): error: -147 ns, adjusted frequency from 2299774950 Hz to 2299774253 Hz I0229 20:25:45.338064 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:45.338192 59450 parameters.go:238] Clock(Realtime): error: 321 ns, adjusted frequency from 2299773949 Hz to 2299775346 Hz D0229 20:25:45.338276 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:45.338299 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968863681778178 monotonicBaseRef:17000349136 monotonicFrequency:2299774253 realtimeReady:1 realtimeBaseCycles:8968863682324117 realtimeBaseRef:1583007945338185902 realtimeFrequency:2299775346} D0229 20:25:45.338422 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:45.338558 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:45.338729 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:45.338842 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:45.339004 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:45.339223 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:45.536554 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:45.536799 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:45.536941 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:45.537045 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:45.537281 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:45.537482 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:46.337909 59450 parameters.go:238] Clock(Monotonic): error: 166 ns, adjusted frequency from 2299774253 Hz to 2299775164 Hz D0229 20:25:46.338190 59450 parameters.go:238] Clock(Realtime): error: -102 ns, adjusted frequency from 2299775346 Hz to 2299774367 Hz D0229 20:25:46.338347 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968865981404134 monotonicBaseRef:18000284652 monotonicFrequency:2299775164 realtimeReady:1 realtimeBaseCycles:8968865982094949 realtimeBaseRef:1583007946338183939 realtimeFrequency:2299774367} I0229 20:25:46.536440 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:46.536640 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:46.536736 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:46.536891 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:46.537035 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:46.537155 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:46.547986 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:46.548245 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:46.548410 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:46.548500 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:46.548726 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:46.548833 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:47.338019 59450 parameters.go:238] Clock(Monotonic): error: 213 ns, adjusted frequency from 2299775164 Hz to 2299775121 Hz I0229 20:25:47.338182 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:47.338393 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:47.338525 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:47.338295 59450 parameters.go:238] Clock(Realtime): error: 338 ns, adjusted frequency from 2299774367 Hz to 2299775404 Hz I0229 20:25:47.338686 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:47.338563 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:47.338816 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:47.338720 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968868281325537 monotonicBaseRef:19000348240 monotonicFrequency:2299775121 realtimeReady:1 realtimeBaseCycles:8968868282104312 realtimeBaseRef:1583007947338286121 realtimeFrequency:2299775404} I0229 20:25:47.338960 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:47.339022 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:47.339096 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:47.339142 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:47.339232 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:47.339560 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:47.339614 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:47.339693 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:47.339777 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:25:47.339970 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:25:48.338696 59450 parameters.go:238] Clock(Monotonic): error: -464 ns, adjusted frequency from 2299775121 Hz to 2299773665 Hz D0229 20:25:48.339019 59450 parameters.go:238] Clock(Realtime): error: -83 ns, adjusted frequency from 2299775404 Hz to 2299774409 Hz D0229 20:25:48.339146 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968870582777943 monotonicBaseRef:20001077565 monotonicFrequency:2299773665 realtimeReady:1 realtimeBaseCycles:8968870583549387 realtimeBaseRef:1583007948339012135 realtimeFrequency:2299774409} D0229 20:25:49.338206 59450 parameters.go:238] Clock(Monotonic): error: 409 ns, adjusted frequency from 2299773665 Hz to 2299775703 Hz D0229 20:25:49.338459 59450 parameters.go:238] Clock(Realtime): error: -87 ns, adjusted frequency from 2299774409 Hz to 2299774478 Hz D0229 20:25:49.338589 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968872881428530 monotonicBaseRef:21000589222 monotonicFrequency:2299775703 realtimeReady:1 realtimeBaseCycles:8968872882037625 realtimeBaseRef:1583007949338452875 realtimeFrequency:2299774478} D0229 20:25:50.337952 59450 parameters.go:238] Clock(Monotonic): error: -494 ns, adjusted frequency from 2299775703 Hz to 2299773491 Hz I0229 20:25:50.338080 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:50.338208 59450 parameters.go:238] Clock(Realtime): error: -60 ns, adjusted frequency from 2299774478 Hz to 2299774461 Hz D0229 20:25:50.338287 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:50.338417 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:50.338337 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968875180608587 monotonicBaseRef:22000330220 monotonicFrequency:2299773491 realtimeReady:1 realtimeBaseCycles:8968875181233260 realtimeBaseRef:1583007950338201179 realtimeFrequency:2299774461} D0229 20:25:50.338550 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:50.338624 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:50.338745 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:50.338874 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:50.339038 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:50.536384 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:50.536641 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:50.536760 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:50.536907 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:50.536878 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:50.537004 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:50.537133 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:50.537296 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:51.337917 59450 parameters.go:238] Clock(Monotonic): error: 31 ns, adjusted frequency from 2299773491 Hz to 2299774723 Hz D0229 20:25:51.338146 59450 parameters.go:238] Clock(Realtime): error: 18 ns, adjusted frequency from 2299774461 Hz to 2299774676 Hz D0229 20:25:51.338306 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968877480313176 monotonicBaseRef:23000300259 monotonicFrequency:2299774723 realtimeReady:1 realtimeBaseCycles:8968877480867836 realtimeBaseRef:1583007951338140353 realtimeFrequency:2299774676} D0229 20:25:52.337967 59450 parameters.go:238] Clock(Monotonic): error: -64 ns, adjusted frequency from 2299774723 Hz to 2299774479 Hz I0229 20:25:52.338138 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:52.338196 59450 parameters.go:238] Clock(Realtime): error: 32 ns, adjusted frequency from 2299774676 Hz to 2299774740 Hz D0229 20:25:52.338418 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:52.338400 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968879780131588 monotonicBaseRef:24000319256 monotonicFrequency:2299774479 realtimeReady:1 realtimeBaseCycles:8968879780755034 realtimeBaseRef:1583007952338189280 realtimeFrequency:2299774740} D0229 20:25:52.338630 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:52.338659 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:52.338807 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:52.338925 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:52.339000 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:52.339086 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:52.339114 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:52.339603 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:52.339564 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:52.339806 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:52.340093 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:25:52.340240 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 20:25:52.536743 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:52.537096 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:52.537261 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:52.537369 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:52.537468 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:52.537582 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:52.537777 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:52.537893 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:52.548445 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:52.548654 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:52.548773 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:52.548806 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:52.549062 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:52.549168 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:53.339269 59450 parameters.go:238] Clock(Monotonic): error: 345 ns, adjusted frequency from 2299774479 Hz to 2299775412 Hz I0229 20:25:53.339433 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:53.339547 59450 parameters.go:238] Clock(Realtime): error: -309 ns, adjusted frequency from 2299774740 Hz to 2299773933 Hz D0229 20:25:53.339684 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:53.339683 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968882082912137 monotonicBaseRef:25001626371 monotonicFrequency:2299775412 realtimeReady:1 realtimeBaseCycles:8968882083619629 realtimeBaseRef:1583007953339532826 realtimeFrequency:2299773933} D0229 20:25:53.339861 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:53.340036 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:53.340236 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:53.340374 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:54.337931 59450 parameters.go:238] Clock(Monotonic): error: -219 ns, adjusted frequency from 2299775412 Hz to 2299774283 Hz D0229 20:25:54.338197 59450 parameters.go:238] Clock(Realtime): error: 343 ns, adjusted frequency from 2299773933 Hz to 2299775403 Hz D0229 20:25:54.338358 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968884379639427 monotonicBaseRef:26000300971 monotonicFrequency:2299774283 realtimeReady:1 realtimeBaseCycles:8968884380304405 realtimeBaseRef:1583007954338189582 realtimeFrequency:2299775403} D0229 20:25:55.337989 59450 parameters.go:238] Clock(Monotonic): error: -21 ns, adjusted frequency from 2299774283 Hz to 2299774585 Hz D0229 20:25:55.338282 59450 parameters.go:238] Clock(Realtime): error: 35 ns, adjusted frequency from 2299775403 Hz to 2299774733 Hz D0229 20:25:55.338451 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968886679572653 monotonicBaseRef:27000370083 monotonicFrequency:2299774585 realtimeReady:1 realtimeBaseCycles:8968886680276904 realtimeBaseRef:1583007955338275284 realtimeFrequency:2299774733} I0229 20:25:55.537247 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:55.537477 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:55.537579 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:55.537828 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:55.538005 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:55.538129 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:56.338689 59450 parameters.go:238] Clock(Monotonic): error: -174 ns, adjusted frequency from 2299774585 Hz to 2299774231 Hz I0229 20:25:56.339786 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:56.340145 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:56.340306 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:56.340684 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:56.340895 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:56.341029 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:56.342049 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:56.342333 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:56.342648 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:56.342908 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:56.343018 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:56.343220 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:56.343386 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:56.343530 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:56.344040 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:56.344273 59450 task_signals.go:452] [ 2] Notified of group signal 23 D0229 20:25:56.338893 59450 parameters.go:238] Clock(Realtime): error: -393 ns, adjusted frequency from 2299774733 Hz to 2299773775 Hz D0229 20:25:56.344458 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:56.344527 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968888980961041 monotonicBaseRef:28001071805 monotonicFrequency:2299774231 realtimeReady:1 realtimeBaseCycles:8968888981458827 realtimeBaseRef:1583007956338887165 realtimeFrequency:2299773775} D0229 20:25:56.344658 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:56.344755 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:56.344768 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:56.344935 59450 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0229 20:25:56.345308 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:56.345446 59450 task_signals.go:452] [ 2] Notified of group signal 23 D0229 20:25:56.345546 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:56.345753 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:25:56.345877 59450 task_signals.go:176] [ 2] Not restarting syscall 219 after errno 516: interrupted by signal 23 D0229 20:25:56.345995 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:25:57.337914 59450 parameters.go:238] Clock(Monotonic): error: 283 ns, adjusted frequency from 2299774231 Hz to 2299775175 Hz I0229 20:25:57.338038 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:57.338145 59450 parameters.go:238] Clock(Realtime): error: 457 ns, adjusted frequency from 2299773775 Hz to 2299775718 Hz D0229 20:25:57.338280 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:57.338406 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:57.338292 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968891278947117 monotonicBaseRef:29000294269 monotonicFrequency:2299775175 realtimeReady:1 realtimeBaseCycles:8968891279511396 realtimeBaseRef:1583007957338138740 realtimeFrequency:2299775718} D0229 20:25:57.338542 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:57.339298 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:57.339442 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:57.340320 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:57.340493 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:57.340607 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:57.340773 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:57.340996 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:57.341137 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:57.537834 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:57.538056 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:57.538215 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:57.538339 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:57.538502 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:57.538630 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:25:58.337886 59450 parameters.go:238] Clock(Monotonic): error: -25 ns, adjusted frequency from 2299775175 Hz to 2299774546 Hz D0229 20:25:58.338118 59450 parameters.go:238] Clock(Realtime): error: -521 ns, adjusted frequency from 2299775718 Hz to 2299773484 Hz D0229 20:25:58.338231 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968893578670433 monotonicBaseRef:30000271719 monotonicFrequency:2299774546 realtimeReady:1 realtimeBaseCycles:8968893579225730 realtimeBaseRef:1583007958338112048 realtimeFrequency:2299773484} D0229 20:25:59.338368 59450 parameters.go:238] Clock(Monotonic): error: -188 ns, adjusted frequency from 2299774546 Hz to 2299774203 Hz I0229 20:25:59.338536 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:59.338634 59450 parameters.go:238] Clock(Realtime): error: 366 ns, adjusted frequency from 2299773484 Hz to 2299775402 Hz D0229 20:25:59.338805 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968895879543076 monotonicBaseRef:31000749199 monotonicFrequency:2299774203 realtimeReady:1 realtimeBaseCycles:8968895880174509 realtimeBaseRef:1583007959338623096 realtimeFrequency:2299775402} D0229 20:25:59.339101 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:59.339236 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:59.339279 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:59.339517 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:59.339682 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:25:59.564761 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:59.564982 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:25:59.565133 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:25:59.565175 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:25:59.565261 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:25:59.565363 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:25:59.565509 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:25:59.565618 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:00.337832 59450 parameters.go:238] Clock(Monotonic): error: 16 ns, adjusted frequency from 2299774203 Hz to 2299774624 Hz I0229 20:26:00.338020 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:00.338073 59450 parameters.go:238] Clock(Realtime): error: -99 ns, adjusted frequency from 2299775402 Hz to 2299774443 Hz D0229 20:26:00.338216 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:00.338343 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:00.338240 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968898178094248 monotonicBaseRef:32000217394 monotonicFrequency:2299774624 realtimeReady:1 realtimeBaseCycles:8968898178664044 realtimeBaseRef:1583007960338063968 realtimeFrequency:2299774443} D0229 20:26:00.338484 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:00.338731 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:00.338900 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:00.884649 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:00.884822 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:00.884979 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:00.885054 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:00.885111 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:00.885256 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:00.885408 59450 urpc.go:577] urpc: unmarshal success. D0229 20:26:00.885409 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:00.885654 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:00.885689 59450 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 20:26:00.886095 59450 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 20:26:01.337949 59450 parameters.go:238] Clock(Monotonic): error: 379 ns, adjusted frequency from 2299774624 Hz to 2299775436 Hz D0229 20:26:01.338147 59450 parameters.go:238] Clock(Realtime): error: 155 ns, adjusted frequency from 2299774443 Hz to 2299774975 Hz I0229 20:26:01.338169 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:01.338359 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:01.338277 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968900478033908 monotonicBaseRef:33000289155 monotonicFrequency:2299775436 realtimeReady:1 realtimeBaseCycles:8968900478613265 realtimeBaseRef:1583007961338139965 realtimeFrequency:2299774975} D0229 20:26:01.338500 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:01.338591 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:01.338627 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:01.338734 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:01.338882 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:01.339012 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:02.337886 59450 parameters.go:238] Clock(Monotonic): error: -404 ns, adjusted frequency from 2299775436 Hz to 2299773837 Hz D0229 20:26:02.338052 59450 parameters.go:238] Clock(Realtime): error: -309 ns, adjusted frequency from 2299774975 Hz to 2299773869 Hz D0229 20:26:02.338181 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968902777772530 monotonicBaseRef:34000273147 monotonicFrequency:2299773837 realtimeReady:1 realtimeBaseCycles:8968902778174951 realtimeBaseRef:1583007962338047221 realtimeFrequency:2299773869} D0229 20:26:03.337922 59450 parameters.go:238] Clock(Monotonic): error: -82 ns, adjusted frequency from 2299773837 Hz to 2299774442 Hz D0229 20:26:03.338105 59450 parameters.go:238] Clock(Realtime): error: 90 ns, adjusted frequency from 2299773869 Hz to 2299774839 Hz D0229 20:26:03.338202 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968905077620303 monotonicBaseRef:35000305296 monotonicFrequency:2299774442 realtimeReady:1 realtimeBaseCycles:8968905078067428 realtimeBaseRef:1583007963338098794 realtimeFrequency:2299774839} I0229 20:26:03.536563 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:03.536741 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:03.536868 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:03.536991 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:03.537207 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:03.537238 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:03.537373 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:03.537391 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:03.537500 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:03.537854 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:03.537956 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:03.537997 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:03.538174 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:03.538297 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:04.337912 59450 parameters.go:238] Clock(Monotonic): error: 417 ns, adjusted frequency from 2299774442 Hz to 2299775491 Hz I0229 20:26:04.337987 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:04.338079 59450 parameters.go:238] Clock(Realtime): error: 85 ns, adjusted frequency from 2299774839 Hz to 2299774840 Hz D0229 20:26:04.338192 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:04.338178 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968907377371461 monotonicBaseRef:36000295171 monotonicFrequency:2299775491 realtimeReady:1 realtimeBaseCycles:8968907377781871 realtimeBaseRef:1583007964338072532 realtimeFrequency:2299774840} D0229 20:26:04.338311 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:04.338375 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:04.338636 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:04.338761 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:05.337866 59450 parameters.go:238] Clock(Monotonic): error: 154 ns, adjusted frequency from 2299775491 Hz to 2299774913 Hz D0229 20:26:05.338057 59450 parameters.go:238] Clock(Realtime): error: 256 ns, adjusted frequency from 2299774840 Hz to 2299775197 Hz D0229 20:26:05.338242 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968909677044743 monotonicBaseRef:37000250727 monotonicFrequency:2299774913 realtimeReady:1 realtimeBaseCycles:8968909677507207 realtimeBaseRef:1583007965338051006 realtimeFrequency:2299775197} I0229 20:26:05.537078 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:05.537256 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:05.537396 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:05.537499 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:05.537632 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:05.537554 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:05.537798 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:05.537940 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:06.337907 59450 parameters.go:238] Clock(Monotonic): error: -362 ns, adjusted frequency from 2299774913 Hz to 2299773912 Hz D0229 20:26:06.338095 59450 parameters.go:238] Clock(Realtime): error: -216 ns, adjusted frequency from 2299775197 Hz to 2299774133 Hz D0229 20:26:06.338417 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968911976903935 monotonicBaseRef:38000287373 monotonicFrequency:2299773912 realtimeReady:1 realtimeBaseCycles:8968911977367749 realtimeBaseRef:1583007966338088116 realtimeFrequency:2299774133} D0229 20:26:07.337907 59450 parameters.go:238] Clock(Monotonic): error: 125 ns, adjusted frequency from 2299773912 Hz to 2299774856 Hz I0229 20:26:07.338025 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:07.338127 59450 parameters.go:238] Clock(Realtime): error: 162 ns, adjusted frequency from 2299774133 Hz to 2299774945 Hz D0229 20:26:07.338351 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:07.338554 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:07.338596 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:07.338722 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:07.338273 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968914276688667 monotonicBaseRef:39000292077 monotonicFrequency:2299774856 realtimeReady:1 realtimeBaseCycles:8968914277214604 realtimeBaseRef:1583007967338119737 realtimeFrequency:2299774945} D0229 20:26:07.338853 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:07.338847 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:07.338953 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:07.338976 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:07.339504 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:07.339612 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:07.339648 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:07.339832 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:07.339947 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:08.337778 59450 parameters.go:238] Clock(Monotonic): error: 312 ns, adjusted frequency from 2299774856 Hz to 2299775309 Hz D0229 20:26:08.338008 59450 parameters.go:238] Clock(Realtime): error: 45 ns, adjusted frequency from 2299774945 Hz to 2299774811 Hz I0229 20:26:08.337978 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:08.338262 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:08.338181 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968916576165774 monotonicBaseRef:40000162608 monotonicFrequency:2299775309 realtimeReady:1 realtimeBaseCycles:8968916576716646 realtimeBaseRef:1583007968338001071 realtimeFrequency:2299774811} D0229 20:26:08.338423 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:08.338566 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:08.338827 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:08.338958 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:08.536425 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:08.536672 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:08.536847 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:08.537023 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:08.537007 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:08.537129 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:08.537296 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:08.537496 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:09.337865 59450 parameters.go:238] Clock(Monotonic): error: -342 ns, adjusted frequency from 2299775309 Hz to 2299773898 Hz I0229 20:26:09.338057 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:09.338141 59450 parameters.go:238] Clock(Realtime): error: -17 ns, adjusted frequency from 2299774811 Hz to 2299774582 Hz D0229 20:26:09.338281 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:09.338263 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968918876137585 monotonicBaseRef:41000248051 monotonicFrequency:2299773898 realtimeReady:1 realtimeBaseCycles:8968918876796275 realtimeBaseRef:1583007969338133613 realtimeFrequency:2299774582} D0229 20:26:09.338417 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:09.338500 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:09.338750 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:09.338877 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:09.536448 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:09.536702 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:09.536867 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:09.536911 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:09.537113 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:09.537237 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:09.564748 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:09.564939 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:09.565055 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:09.565173 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:09.565284 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:09.565408 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:09.565589 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:09.565711 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:10.337883 59450 parameters.go:238] Clock(Monotonic): error: -39 ns, adjusted frequency from 2299773898 Hz to 2299774617 Hz D0229 20:26:10.338139 59450 parameters.go:238] Clock(Realtime): error: -22 ns, adjusted frequency from 2299774582 Hz to 2299774589 Hz D0229 20:26:10.338236 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968921175958748 monotonicBaseRef:42000268603 monotonicFrequency:2299774617 realtimeReady:1 realtimeBaseCycles:8968921176566362 realtimeBaseRef:1583007970338131658 realtimeFrequency:2299774589} D0229 20:26:11.337937 59450 parameters.go:238] Clock(Monotonic): error: 267 ns, adjusted frequency from 2299774617 Hz to 2299775151 Hz I0229 20:26:11.338055 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:11.338138 59450 parameters.go:238] Clock(Realtime): error: -126 ns, adjusted frequency from 2299774589 Hz to 2299774365 Hz D0229 20:26:11.338280 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968923475808456 monotonicBaseRef:43000301254 monotonicFrequency:2299775151 realtimeReady:1 realtimeBaseCycles:8968923476342475 realtimeBaseRef:1583007971338132320 realtimeFrequency:2299774365} D0229 20:26:11.338257 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:11.338864 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:11.338896 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:11.339096 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:11.339211 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:12.337851 59450 parameters.go:238] Clock(Monotonic): error: -82 ns, adjusted frequency from 2299775151 Hz to 2299774335 Hz D0229 20:26:12.338027 59450 parameters.go:238] Clock(Realtime): error: -130 ns, adjusted frequency from 2299774365 Hz to 2299774357 Hz D0229 20:26:12.338150 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968925775441779 monotonicBaseRef:44000239583 monotonicFrequency:2299774335 realtimeReady:1 realtimeBaseCycles:8968925775864496 realtimeBaseRef:1583007972338022594 realtimeFrequency:2299774357} I0229 20:26:12.536451 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:12.536670 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:12.536798 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:12.536902 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:12.536977 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:12.537105 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:12.537154 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:12.537329 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:12.537499 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:12.538092 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:12.538133 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:12.538242 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:12.538465 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:12.538635 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:13.338788 59450 parameters.go:238] Clock(Monotonic): error: -226 ns, adjusted frequency from 2299774335 Hz to 2299774203 Hz D0229 20:26:13.338972 59450 parameters.go:238] Clock(Realtime): error: 35 ns, adjusted frequency from 2299774357 Hz to 2299774722 Hz D0229 20:26:13.339121 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968928077366783 monotonicBaseRef:45001174748 monotonicFrequency:2299774203 realtimeReady:1 realtimeBaseCycles:8968928077805996 realtimeBaseRef:1583007973338964922 realtimeFrequency:2299774722} I0229 20:26:13.521940 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:13.522198 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:13.522296 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:13.522277 59450 watchdog.go:277] Watchdog starting loop, tasks: 16, discount: 0s I0229 20:26:13.522452 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:13.522456 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:13.522586 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:13.522798 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:13.522969 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:13.536505 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:13.536756 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:13.536916 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:13.537126 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:13.537081 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:13.537239 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:13.537448 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:13.537595 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:13.548029 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:13.548282 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:13.548400 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:13.548515 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:13.548613 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:13.548725 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:13.548761 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:13.548866 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:13.548906 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:13.549296 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:13.549409 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:13.549444 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:13.549630 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:13.549792 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:14.337969 59450 parameters.go:238] Clock(Monotonic): error: -123 ns, adjusted frequency from 2299774203 Hz to 2299774417 Hz D0229 20:26:14.338140 59450 parameters.go:238] Clock(Realtime): error: -102 ns, adjusted frequency from 2299774722 Hz to 2299774391 Hz D0229 20:26:14.338243 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968930375213460 monotonicBaseRef:46000336610 monotonicFrequency:2299774417 realtimeReady:1 realtimeBaseCycles:8968930375671049 realtimeBaseRef:1583007974338134549 realtimeFrequency:2299774391} D0229 20:26:15.337943 59450 parameters.go:238] Clock(Monotonic): error: 392 ns, adjusted frequency from 2299774417 Hz to 2299775434 Hz D0229 20:26:15.338133 59450 parameters.go:238] Clock(Realtime): error: 229 ns, adjusted frequency from 2299774391 Hz to 2299775142 Hz D0229 20:26:15.338263 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968932674973973 monotonicBaseRef:47000330564 monotonicFrequency:2299775434 realtimeReady:1 realtimeBaseCycles:8968932675427875 realtimeBaseRef:1583007975338126911 realtimeFrequency:2299775142} D0229 20:26:16.338209 59450 parameters.go:238] Clock(Monotonic): error: -152 ns, adjusted frequency from 2299775434 Hz to 2299774395 Hz D0229 20:26:16.338454 59450 parameters.go:238] Clock(Realtime): error: 79 ns, adjusted frequency from 2299775142 Hz to 2299774850 Hz D0229 20:26:16.338605 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968934975350584 monotonicBaseRef:48000591970 monotonicFrequency:2299774395 realtimeReady:1 realtimeBaseCycles:8968934975940387 realtimeBaseRef:1583007976338447537 realtimeFrequency:2299774850} D0229 20:26:17.337987 59450 parameters.go:238] Clock(Monotonic): error: -62 ns, adjusted frequency from 2299774395 Hz to 2299774537 Hz D0229 20:26:17.338266 59450 parameters.go:238] Clock(Realtime): error: -77 ns, adjusted frequency from 2299774850 Hz to 2299774367 Hz D0229 20:26:17.338463 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968937274618278 monotonicBaseRef:49000371643 monotonicFrequency:2299774537 realtimeReady:1 realtimeBaseCycles:8968937275275510 realtimeBaseRef:1583007977338256332 realtimeFrequency:2299774367} I0229 20:26:17.536422 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:17.536650 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:17.536778 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:17.536945 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:17.537025 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:17.537098 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:17.537314 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:17.537480 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:17.548643 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:17.548841 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:17.548942 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:17.549065 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:17.549299 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:17.549431 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:18.337901 59450 parameters.go:238] Clock(Monotonic): error: 272 ns, adjusted frequency from 2299774537 Hz to 2299775133 Hz I0229 20:26:18.338000 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:18.338137 59450 parameters.go:238] Clock(Realtime): error: 681 ns, adjusted frequency from 2299774367 Hz to 2299776273 Hz D0229 20:26:18.338197 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:18.338321 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:18.338282 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968939574201518 monotonicBaseRef:50000288462 monotonicFrequency:2299775133 realtimeReady:1 realtimeBaseCycles:8968939574756203 realtimeBaseRef:1583007978338128635 realtimeFrequency:2299776273} D0229 20:26:18.338524 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:18.338523 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:18.338697 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:18.338927 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:18.339034 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:19.337875 59450 parameters.go:238] Clock(Monotonic): error: -15 ns, adjusted frequency from 2299775133 Hz to 2299774500 Hz D0229 20:26:19.338095 59450 parameters.go:238] Clock(Realtime): error: -780 ns, adjusted frequency from 2299776273 Hz to 2299772839 Hz D0229 20:26:19.338192 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968941873913678 monotonicBaseRef:51000261079 monotonicFrequency:2299774500 realtimeReady:1 realtimeBaseCycles:8968941874440740 realtimeBaseRef:1583007979338088745 realtimeFrequency:2299772839} I0229 20:26:19.564597 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:19.564807 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:19.564941 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:19.565074 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:19.565095 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:19.565245 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:19.565430 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:19.565599 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:20.337879 59450 parameters.go:238] Clock(Monotonic): error: 149 ns, adjusted frequency from 2299774500 Hz to 2299775026 Hz I0229 20:26:20.338067 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:20.338217 59450 parameters.go:238] Clock(Realtime): error: 199 ns, adjusted frequency from 2299772839 Hz to 2299775070 Hz D0229 20:26:20.338287 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:20.338416 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:20.338369 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968944173695712 monotonicBaseRef:52000264354 monotonicFrequency:2299775026 realtimeReady:1 realtimeBaseCycles:8968944174487164 realtimeBaseRef:1583007980338207706 realtimeFrequency:2299775070} D0229 20:26:20.338601 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:20.338865 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:20.339008 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:21.337937 59450 parameters.go:238] Clock(Monotonic): error: -137 ns, adjusted frequency from 2299775026 Hz to 2299774320 Hz I0229 20:26:21.338042 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:21.338125 59450 parameters.go:238] Clock(Realtime): error: -119 ns, adjusted frequency from 2299775070 Hz to 2299774309 Hz D0229 20:26:21.338237 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:21.338354 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:21.338402 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:21.338296 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968946473608383 monotonicBaseRef:53000324205 monotonicFrequency:2299774320 realtimeReady:1 realtimeBaseCycles:8968946474056991 realtimeBaseRef:1583007981338118461 realtimeFrequency:2299774309} D0229 20:26:21.338629 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:21.338802 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:22.337909 59450 parameters.go:238] Clock(Monotonic): error: 311 ns, adjusted frequency from 2299774320 Hz to 2299775303 Hz I0229 20:26:22.338045 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:22.338168 59450 parameters.go:238] Clock(Realtime): error: 382 ns, adjusted frequency from 2299774309 Hz to 2299775543 Hz D0229 20:26:22.338224 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:22.338397 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:22.338434 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:22.338545 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:22.338349 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968948773310100 monotonicBaseRef:54000292635 monotonicFrequency:2299775303 realtimeReady:1 realtimeBaseCycles:8968948773927955 realtimeBaseRef:1583007982338160489 realtimeFrequency:2299775543} D0229 20:26:22.338643 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:22.338665 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:22.338760 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:22.338920 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:22.339221 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:22.339344 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:22.339329 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:22.339636 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:22.339763 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 20:26:22.536461 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:22.536664 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:22.536791 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:22.536941 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:22.537160 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:22.537322 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:23.337899 59450 parameters.go:238] Clock(Monotonic): error: -720 ns, adjusted frequency from 2299775303 Hz to 2299772985 Hz I0229 20:26:23.338074 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:23.338187 59450 parameters.go:238] Clock(Realtime): error: -310 ns, adjusted frequency from 2299775543 Hz to 2299773921 Hz D0229 20:26:23.338318 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:23.338665 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:23.338362 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968951073064162 monotonicBaseRef:55000283398 monotonicFrequency:2299772985 realtimeReady:1 realtimeBaseCycles:8968951073744783 realtimeBaseRef:1583007983338178440 realtimeFrequency:2299773921} D0229 20:26:23.338529 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:23.341112 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:23.341172 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:23.341250 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:23.341310 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:23.341351 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:23.341674 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:23.341754 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:23.341793 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:23.342070 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:23.342204 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:24.337908 59450 parameters.go:238] Clock(Monotonic): error: 613 ns, adjusted frequency from 2299772985 Hz to 2299776047 Hz D0229 20:26:24.338166 59450 parameters.go:238] Clock(Realtime): error: 194 ns, adjusted frequency from 2299773921 Hz to 2299775128 Hz D0229 20:26:24.338327 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968953372808452 monotonicBaseRef:56000270920 monotonicFrequency:2299776047 realtimeReady:1 realtimeBaseCycles:8968953373472126 realtimeBaseRef:1583007984338158186 realtimeFrequency:2299775128} I0229 20:26:24.536623 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:24.536871 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:24.536961 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:24.537101 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:24.537107 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:24.537226 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:24.537342 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:24.537490 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:25.337904 59450 parameters.go:238] Clock(Monotonic): error: -460 ns, adjusted frequency from 2299776047 Hz to 2299773460 Hz I0229 20:26:25.338020 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:25.338155 59450 parameters.go:238] Clock(Realtime): error: -432 ns, adjusted frequency from 2299775128 Hz to 2299773624 Hz D0229 20:26:25.338247 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:25.338349 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:25.338383 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:25.338290 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968955672623012 monotonicBaseRef:57000287666 monotonicFrequency:2299773460 realtimeReady:1 realtimeBaseCycles:8968955673218758 realtimeBaseRef:1583007985338145795 realtimeFrequency:2299773624} D0229 20:26:25.338599 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:25.338722 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:26.338482 59450 parameters.go:238] Clock(Monotonic): error: -17 ns, adjusted frequency from 2299773460 Hz to 2299774599 Hz D0229 20:26:26.338706 59450 parameters.go:238] Clock(Realtime): error: 206 ns, adjusted frequency from 2299773624 Hz to 2299775162 Hz D0229 20:26:26.338852 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968957973720016 monotonicBaseRef:58000863176 monotonicFrequency:2299774599 realtimeReady:1 realtimeBaseCycles:8968957974264564 realtimeBaseRef:1583007986338698972 realtimeFrequency:2299775162} D0229 20:26:27.337912 59450 parameters.go:238] Clock(Monotonic): error: 394 ns, adjusted frequency from 2299774599 Hz to 2299775533 Hz D0229 20:26:27.338139 59450 parameters.go:238] Clock(Realtime): error: -114 ns, adjusted frequency from 2299775162 Hz to 2299774303 Hz D0229 20:26:27.338264 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968960272185924 monotonicBaseRef:59000294124 monotonicFrequency:2299775533 realtimeReady:1 realtimeBaseCycles:8968960272739731 realtimeBaseRef:1583007987338133701 realtimeFrequency:2299774303} D0229 20:26:28.338373 59450 parameters.go:238] Clock(Monotonic): error: -371 ns, adjusted frequency from 2299775533 Hz to 2299773878 Hz D0229 20:26:28.338622 59450 parameters.go:238] Clock(Realtime): error: 30 ns, adjusted frequency from 2299774303 Hz to 2299774726 Hz D0229 20:26:28.338718 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968962573017527 monotonicBaseRef:60000753329 monotonicFrequency:2299773878 realtimeReady:1 realtimeBaseCycles:8968962573624645 realtimeBaseRef:1583007988338616622 realtimeFrequency:2299774726} D0229 20:26:29.337899 59450 parameters.go:238] Clock(Monotonic): error: -108 ns, adjusted frequency from 2299773878 Hz to 2299774431 Hz I0229 20:26:29.337976 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:29.338096 59450 parameters.go:238] Clock(Realtime): error: 38 ns, adjusted frequency from 2299774726 Hz to 2299774759 Hz D0229 20:26:29.338215 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:29.338354 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:29.338253 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968964871710434 monotonicBaseRef:61000283295 monotonicFrequency:2299774431 realtimeReady:1 realtimeBaseCycles:8968964872187513 realtimeBaseRef:1583007989338089675 realtimeFrequency:2299774759} I0229 20:26:29.338490 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:29.338449 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:29.338629 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:29.338834 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:29.338973 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:29.564584 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:29.564864 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:29.565005 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:29.565135 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:29.565183 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:29.565316 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:29.565430 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:29.565432 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:29.565558 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:29.565907 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:29.566056 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:29.566048 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:29.566233 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:29.566391 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:30.338742 59450 parameters.go:238] Clock(Monotonic): error: 212 ns, adjusted frequency from 2299774431 Hz to 2299775074 Hz D0229 20:26:30.338962 59450 parameters.go:238] Clock(Realtime): error: 115 ns, adjusted frequency from 2299774759 Hz to 2299774963 Hz D0229 20:26:30.339093 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968967173427773 monotonicBaseRef:62001128120 monotonicFrequency:2299775074 realtimeReady:1 realtimeBaseCycles:8968967173954851 realtimeBaseRef:1583007990338956098 realtimeFrequency:2299774963} D0229 20:26:31.337911 59450 parameters.go:238] Clock(Monotonic): error: 304 ns, adjusted frequency from 2299775074 Hz to 2299775307 Hz D0229 20:26:31.338109 59450 parameters.go:238] Clock(Realtime): error: -182 ns, adjusted frequency from 2299774963 Hz to 2299774206 Hz D0229 20:26:31.338223 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968969471286915 monotonicBaseRef:63000295024 monotonicFrequency:2299775307 realtimeReady:1 realtimeBaseCycles:8968969471768290 realtimeBaseRef:1583007991338103178 realtimeFrequency:2299774206} I0229 20:26:31.424978 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:31.425181 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:31.425274 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:31.425392 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:31.425397 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:31.425481 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:31.425660 59450 urpc.go:577] urpc: unmarshal success. D0229 20:26:31.425700 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:31.425845 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:31.425926 59450 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 20:26:31.426213 59450 urpc.go:534] urpc: successfully marshalled 37 bytes. I0229 20:26:31.536544 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:31.536745 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:31.536873 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:31.536904 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:31.537130 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:31.537552 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:32.337940 59450 parameters.go:238] Clock(Monotonic): error: -340 ns, adjusted frequency from 2299775307 Hz to 2299773863 Hz D0229 20:26:32.338202 59450 parameters.go:238] Clock(Realtime): error: 11 ns, adjusted frequency from 2299774206 Hz to 2299774584 Hz D0229 20:26:32.338411 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968971771124746 monotonicBaseRef:64000322211 monotonicFrequency:2299773863 realtimeReady:1 realtimeBaseCycles:8968971771750052 realtimeBaseRef:1583007992338193428 realtimeFrequency:2299774584} D0229 20:26:33.337909 59450 parameters.go:238] Clock(Monotonic): error: 27 ns, adjusted frequency from 2299773863 Hz to 2299774800 Hz D0229 20:26:33.338120 59450 parameters.go:238] Clock(Realtime): error: 259 ns, adjusted frequency from 2299774584 Hz to 2299775214 Hz D0229 20:26:33.338268 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968974070792969 monotonicBaseRef:65000276276 monotonicFrequency:2299774800 realtimeReady:1 realtimeBaseCycles:8968974071339504 realtimeBaseRef:1583007993338112927 realtimeFrequency:2299775214} I0229 20:26:34.338020 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:34.338215 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:34.338319 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:34.337970 59450 parameters.go:238] Clock(Monotonic): error: 327 ns, adjusted frequency from 2299774800 Hz to 2299775415 Hz D0229 20:26:34.338371 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:34.338493 59450 parameters.go:238] Clock(Realtime): error: -385 ns, adjusted frequency from 2299775214 Hz to 2299773761 Hz D0229 20:26:34.338615 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:34.338639 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968976370669170 monotonicBaseRef:66000320367 monotonicFrequency:2299775415 realtimeReady:1 realtimeBaseCycles:8968976371973540 realtimeBaseRef:1583007994338486364 realtimeFrequency:2299773761} D0229 20:26:34.338756 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:35.339241 59450 parameters.go:238] Clock(Monotonic): error: -478 ns, adjusted frequency from 2299775415 Hz to 2299773536 Hz D0229 20:26:35.339481 59450 parameters.go:238] Clock(Realtime): error: 229 ns, adjusted frequency from 2299773761 Hz to 2299775173 Hz D0229 20:26:35.339657 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968978673429086 monotonicBaseRef:67001618102 monotonicFrequency:2299773536 realtimeReady:1 realtimeBaseCycles:8968978674022039 realtimeBaseRef:1583007995339475477 realtimeFrequency:2299775173} I0229 20:26:35.536470 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:35.536675 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:35.536945 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:35.536978 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:35.537163 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:35.537290 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:36.337871 59450 parameters.go:238] Clock(Monotonic): error: -150 ns, adjusted frequency from 2299773536 Hz to 2299774403 Hz D0229 20:26:36.338059 59450 parameters.go:238] Clock(Realtime): error: -291 ns, adjusted frequency from 2299775173 Hz to 2299773964 Hz D0229 20:26:36.338182 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968980970073342 monotonicBaseRef:68000257411 monotonicFrequency:2299774403 realtimeReady:1 realtimeBaseCycles:8968980970530595 realtimeBaseRef:1583007996338055069 realtimeFrequency:2299773964} I0229 20:26:36.536525 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:36.536725 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:36.536829 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:36.536908 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:36.537126 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:36.537216 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:37.337959 59450 parameters.go:238] Clock(Monotonic): error: 339 ns, adjusted frequency from 2299774403 Hz to 2299775276 Hz I0229 20:26:37.338113 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:37.338233 59450 parameters.go:238] Clock(Realtime): error: 301 ns, adjusted frequency from 2299773964 Hz to 2299775272 Hz D0229 20:26:37.338335 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:37.338432 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:37.338389 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968983270043597 monotonicBaseRef:69000342572 monotonicFrequency:2299775276 realtimeReady:1 realtimeBaseCycles:8968983270697524 realtimeBaseRef:1583007997338225940 realtimeFrequency:2299775272} D0229 20:26:37.338585 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:37.338646 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:37.338774 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:37.339094 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:37.339219 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:38.337986 59450 parameters.go:238] Clock(Monotonic): error: -327 ns, adjusted frequency from 2299775276 Hz to 2299773883 Hz D0229 20:26:38.338197 59450 parameters.go:238] Clock(Realtime): error: -221 ns, adjusted frequency from 2299775272 Hz to 2299774114 Hz D0229 20:26:38.338290 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968985569864743 monotonicBaseRef:70000362517 monotonicFrequency:2299773883 realtimeReady:1 realtimeBaseCycles:8968985570397454 realtimeBaseRef:1583007998338193179 realtimeFrequency:2299774114} I0229 20:26:38.536603 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:38.536800 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:38.537023 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:38.537086 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:38.537404 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:38.537582 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:39.338038 59450 parameters.go:238] Clock(Monotonic): error: 23 ns, adjusted frequency from 2299773883 Hz to 2299774833 Hz D0229 20:26:39.338213 59450 parameters.go:238] Clock(Realtime): error: 35 ns, adjusted frequency from 2299774114 Hz to 2299774685 Hz I0229 20:26:39.338195 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:39.338322 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968987869766908 monotonicBaseRef:71000418297 monotonicFrequency:2299774833 realtimeReady:1 realtimeBaseCycles:8968987870205864 realtimeBaseRef:1583007999338208091 realtimeFrequency:2299774685} D0229 20:26:39.338420 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:39.338629 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:39.338583 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:39.339285 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:39.339426 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:39.339540 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:39.339672 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:39.339622 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:39.340284 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:39.340427 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:39.340400 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:39.340818 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:39.340966 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 20:26:39.536621 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:39.536874 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:39.537030 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:39.537213 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:39.537357 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:39.537479 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:40.338033 59450 parameters.go:238] Clock(Monotonic): error: -88 ns, adjusted frequency from 2299774833 Hz to 2299774498 Hz I0229 20:26:40.338123 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:40.338236 59450 parameters.go:238] Clock(Realtime): error: 203 ns, adjusted frequency from 2299774685 Hz to 2299775110 Hz D0229 20:26:40.338306 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:40.338428 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:40.338359 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968990169546995 monotonicBaseRef:72000420581 monotonicFrequency:2299774498 realtimeReady:1 realtimeBaseCycles:8968990170030996 realtimeBaseRef:1583008000338230026 realtimeFrequency:2299775110} D0229 20:26:40.338507 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:40.338855 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 20:26:40.338546 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:40.339032 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:40.339120 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:40.339252 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:40.339417 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:40.339439 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:40.339515 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:40.339791 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:40.339908 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:41.337970 59450 parameters.go:238] Clock(Monotonic): error: 296 ns, adjusted frequency from 2299774498 Hz to 2299775179 Hz D0229 20:26:41.338160 59450 parameters.go:238] Clock(Realtime): error: -121 ns, adjusted frequency from 2299775110 Hz to 2299774442 Hz D0229 20:26:41.338316 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968992469175280 monotonicBaseRef:73000357003 monotonicFrequency:2299775179 realtimeReady:1 realtimeBaseCycles:8968992469636123 realtimeBaseRef:1583008001338156113 realtimeFrequency:2299774442} D0229 20:26:42.337933 59450 parameters.go:238] Clock(Monotonic): error: -266 ns, adjusted frequency from 2299775179 Hz to 2299773995 Hz D0229 20:26:42.338176 59450 parameters.go:238] Clock(Realtime): error: -123 ns, adjusted frequency from 2299774442 Hz to 2299774289 Hz I0229 20:26:42.338066 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:42.338324 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968994768855832 monotonicBaseRef:74000315856 monotonicFrequency:2299773995 realtimeReady:1 realtimeBaseCycles:8968994769442562 realtimeBaseRef:1583008002338170026 realtimeFrequency:2299774289} D0229 20:26:42.338480 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:42.338599 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:42.338734 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:42.338766 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:42.338860 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:42.338997 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:42.339091 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:42.536600 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:42.536906 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:42.537021 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:42.537216 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:42.537228 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:42.537394 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:42.537556 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:42.537676 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:42.547918 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:42.548105 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:42.548217 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:42.548257 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:42.548506 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:42.548670 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:43.337922 59450 parameters.go:238] Clock(Monotonic): error: 1 ns, adjusted frequency from 2299773995 Hz to 2299774711 Hz I0229 20:26:43.338092 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:43.338180 59450 parameters.go:238] Clock(Realtime): error: 242 ns, adjusted frequency from 2299774289 Hz to 2299775201 Hz D0229 20:26:43.338310 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:43.338425 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:43.338321 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968997068603048 monotonicBaseRef:75000304211 monotonicFrequency:2299774711 realtimeReady:1 realtimeBaseCycles:8968997069224732 realtimeBaseRef:1583008003338173452 realtimeFrequency:2299775201} D0229 20:26:43.338469 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:43.338585 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:43.338691 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:43.338676 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:43.338771 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:43.338803 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:43.339173 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:43.339209 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:43.339251 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:43.339362 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:43.339496 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:44.337954 59450 parameters.go:238] Clock(Monotonic): error: 315 ns, adjusted frequency from 2299774711 Hz to 2299775207 Hz I0229 20:26:44.338045 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:44.338114 59450 parameters.go:238] Clock(Realtime): error: -254 ns, adjusted frequency from 2299775201 Hz to 2299774082 Hz D0229 20:26:44.338222 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:44.338208 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8968999368308996 monotonicBaseRef:76000274311 monotonicFrequency:2299775207 realtimeReady:1 realtimeBaseCycles:8968999368850487 realtimeBaseRef:1583008004338108469 realtimeFrequency:2299774082} D0229 20:26:44.338366 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:44.338496 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:44.338525 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:44.338673 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:44.338834 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:44.338934 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:45.337885 59450 parameters.go:238] Clock(Monotonic): error: 350 ns, adjusted frequency from 2299775207 Hz to 2299775371 Hz I0229 20:26:45.338006 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:45.338117 59450 parameters.go:238] Clock(Realtime): error: 274 ns, adjusted frequency from 2299774082 Hz to 2299775239 Hz D0229 20:26:45.338225 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:45.338294 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8969001668019859 monotonicBaseRef:77000246332 monotonicFrequency:2299775371 realtimeReady:1 realtimeBaseCycles:8969001668627016 realtimeBaseRef:1583008005338109533 realtimeFrequency:2299775239} D0229 20:26:45.338431 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:45.338475 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:45.338795 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:45.338926 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:46.337943 59450 parameters.go:238] Clock(Monotonic): error: -419 ns, adjusted frequency from 2299775371 Hz to 2299773633 Hz I0229 20:26:46.338128 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:46.338200 59450 parameters.go:238] Clock(Realtime): error: 127 ns, adjusted frequency from 2299775239 Hz to 2299774978 Hz D0229 20:26:46.338346 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:46.338328 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8969003967985142 monotonicBaseRef:78000328910 monotonicFrequency:2299773633 realtimeReady:1 realtimeBaseCycles:8969003968593745 realtimeBaseRef:1583008006338192797 realtimeFrequency:2299774978} D0229 20:26:46.338451 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:46.338498 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:46.338653 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:46.338803 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:46.338980 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:46.339141 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:47.337926 59450 parameters.go:238] Clock(Monotonic): error: 132 ns, adjusted frequency from 2299773633 Hz to 2299774804 Hz I0229 20:26:47.338073 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:47.338119 59450 parameters.go:238] Clock(Realtime): error: -375 ns, adjusted frequency from 2299774978 Hz to 2299773755 Hz D0229 20:26:47.338273 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:47.338279 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8969006267724083 monotonicBaseRef:79000313825 monotonicFrequency:2299774804 realtimeReady:1 realtimeBaseCycles:8969006268187419 realtimeBaseRef:1583008007338113961 realtimeFrequency:2299773755} D0229 20:26:47.338405 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:47.338474 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:47.338833 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:47.339034 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:48.337936 59450 parameters.go:238] Clock(Monotonic): error: 44 ns, adjusted frequency from 2299774804 Hz to 2299774767 Hz D0229 20:26:48.338237 59450 parameters.go:238] Clock(Realtime): error: 271 ns, adjusted frequency from 2299773755 Hz to 2299775244 Hz D0229 20:26:48.338354 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8969008567509298 monotonicBaseRef:80000318351 monotonicFrequency:2299774767 realtimeReady:1 realtimeBaseCycles:8969008568227182 realtimeBaseRef:1583008008338229628 realtimeFrequency:2299775244} I0229 20:26:48.536685 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:48.536944 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:48.537080 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:48.537077 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:48.537297 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 20:26:48.537357 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:48.537443 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:48.537514 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:48.537626 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:48.537968 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:48.538073 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:48.538080 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:48.538278 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:48.538386 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:49.337872 59450 parameters.go:238] Clock(Monotonic): error: 186 ns, adjusted frequency from 2299774767 Hz to 2299774948 Hz D0229 20:26:49.338124 59450 parameters.go:238] Clock(Realtime): error: -279 ns, adjusted frequency from 2299775244 Hz to 2299773963 Hz D0229 20:26:49.338221 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8969010867105970 monotonicBaseRef:81000240910 monotonicFrequency:2299774948 realtimeReady:1 realtimeBaseCycles:8969010867747994 realtimeBaseRef:1583008009338118994 realtimeFrequency:2299773963} I0229 20:26:49.536542 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:49.537458 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:49.537628 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:49.537720 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:49.537792 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:49.537896 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:49.538108 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:49.538300 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.337867 59450 parameters.go:238] Clock(Monotonic): error: -208 ns, adjusted frequency from 2299774948 Hz to 2299774291 Hz I0229 20:26:50.338013 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.338158 59450 parameters.go:238] Clock(Realtime): error: 253 ns, adjusted frequency from 2299773963 Hz to 2299775202 Hz D0229 20:26:50.338205 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.338296 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.338333 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.338273 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8969013166889651 monotonicBaseRef:82000244707 monotonicFrequency:2299774291 realtimeReady:1 realtimeBaseCycles:8969013167595638 realtimeBaseRef:1583008010338151032 realtimeFrequency:2299775202} D0229 20:26:50.338579 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.338735 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:50.406788 63920 main.go:305] *************************** I0229 20:26:50.406899 63920 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 /syzkaller130508299] I0229 20:26:50.407358 63920 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 20:26:50.407431 63920 main.go:308] PID: 63920 I0229 20:26:50.407492 63920 main.go:309] UID: 0, GID: 0 I0229 20:26:50.407571 63920 main.go:310] Configuration: I0229 20:26:50.407640 63920 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 20:26:50.407762 63920 main.go:312] Platform: ptrace I0229 20:26:50.407839 63920 main.go:313] FileAccess: shared, overlay: false I0229 20:26:50.407959 63920 main.go:314] Network: sandbox, logging: false I0229 20:26:50.408025 63920 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 20:26:50.408088 63920 main.go:316] *************************** W0229 20:26:50.408177 63920 main.go:321] Block the TERM signal. This is only safe in tests! D0229 20:26:50.408551 63920 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.414281 63920 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0229 20:26:50.414425 63920 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.414548 63920 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.414928 63920 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 20:26:50.415054 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.415240 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.415400 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.415453 59450 urpc.go:577] urpc: unmarshal success. D0229 20:26:50.415450 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:50.415513 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.415690 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:50.415695 59450 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 20:26:50.415894 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.416061 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.416025 59450 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 20:26:50.416317 63920 urpc.go:577] urpc: unmarshal success. D0229 20:26:50.416524 63920 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 /syzkaller130508299 D0229 20:26:50.416694 63920 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0229 20:26:50.416893 63920 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 /syzkaller130508299 D0229 20:26:50.417079 63920 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-0" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.417260 63920 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.418447 63920 urpc.go:534] urpc: successfully marshalled 634 bytes. D0229 20:26:50.418840 59450 urpc.go:577] urpc: unmarshal success. D0229 20:26:50.420060 59450 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 /syzkaller130508299 D0229 20:26:50.420688 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0229 20:26:50.421419 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.421547 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 20:26:50.422022 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} I0229 20:26:50.422467 59450 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 /syzkaller130508299] I0229 20:26:50.423137 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.424282 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0229 20:26:50.425674 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] 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: 1583007929, NanoSec: 613849930}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384251}]} D0229 20:26:50.425848 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0229 20:26:50.426515 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.426770 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 20:26:50.427829 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384251}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 24119712, BlockSize: 4096, Blocks: 47112, ATime: {Sec: 1582836029, NanoSec: 349298839}, MTime: {Sec: 1582836029, NanoSec: 349298839}, CTime: {Sec: 1583007929, NanoSec: 613849930}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 20:26:50.428067 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalk{FID: 5, NewFID: 6, Names: []} D0229 20:26:50.428637 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rwalk{QIDs: []} D0229 20:26:50.428880 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tlopen{FID: 6, Flags: ReadOnly} D0229 20:26:50.429736 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384251}, IoUnit: 0, File: &{{36}}} D0229 20:26:50.432935 59450 syscalls.go:266] Allocating stack with size of 8388608 bytes D0229 20:26:50.434539 59450 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-0 0}:0xc00048e8a0 {ci-gvisor-ptrace-proxy-sandbox-race-0 22}:0xc0002eb220] D0229 20:26:50.434847 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.434948 59450 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 20:26:50.435029 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.435147 63920 urpc.go:577] urpc: unmarshal success. I0229 20:26:50.435191 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.435193 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.435314 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:50.435307 63920 container.go:580] Wait on PID 22 in container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.435464 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.435638 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.435431 63920 sandbox.go:761] Waiting for PID 22 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.435563 63920 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:50.435927 63920 urpc.go:534] urpc: successfully marshalled 100 bytes. D0229 20:26:50.436583 59450 urpc.go:577] urpc: unmarshal success. D0229 20:26:50.436857 59450 controller.go:443] containerManager.Wait D0229 20:26:50.439328 59450 task_block.go:223] [ 22] Interrupt queued I0229 20:26:50.547978 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.548227 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.548371 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.548502 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.548784 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.548909 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:50.578059 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.578324 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.578478 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.578630 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.578827 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.579009 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:50.611988 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.612212 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.612336 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.612457 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.612633 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.612768 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.621241 59450 task_block.go:223] [ 23] Interrupt queued D0229 20:26:50.622018 59450 task_block.go:223] [ 24] Interrupt queued D0229 20:26:50.623815 59450 task_block.go:223] [ 25] Interrupt queued D0229 20:26:50.629226 59450 task_block.go:223] [ 26] Interrupt queued D0229 20:26:50.637471 59450 task_block.go:223] [ 27] Interrupt queued D0229 20:26:50.646421 59450 task_block.go:223] [ 28] Interrupt queued D0229 20:26:50.652202 59450 task_block.go:223] [ 29] Interrupt queued D0229 20:26:50.689522 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0229 20:26:50.690083 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.690221 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 20:26:50.690629 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.693891 59450 urpc.go:577] urpc: unmarshal success. D0229 20:26:50.694076 59450 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0229 20:26:50.694300 59450 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 20:26:50.715570 59450 task_block.go:223] [ 30] Interrupt queued D0229 20:26:50.717796 59450 task_block.go:223] [ 31] Interrupt queued D0229 20:26:50.740179 59450 task_block.go:223] [ 32] Interrupt queued D0229 20:26:50.744537 59450 task_block.go:223] [ 33] Interrupt queued D0229 20:26:50.751148 59450 task_block.go:223] [ 34] Interrupt queued I0229 20:26:50.776364 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.777086 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.777219 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.777261 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.777796 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 20:26:50.777870 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.778049 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.778083 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.778181 59450 task_block.go:223] [ 35] Interrupt queued D0229 20:26:50.778271 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.778698 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.778673 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.778975 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.779246 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:50.779401 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 20:26:50.780781 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.781430 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.782496 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.782610 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:50.782660 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.782820 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.782912 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.782990 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.783035 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.783423 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.783523 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.783489 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.783663 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:50.783766 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:50.789473 59450 task_block.go:223] [ 36] Interrupt queued I0229 20:26:50.817938 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.818194 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.818345 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.818383 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.818551 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.818640 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.822077 59450 task_block.go:223] [ 37] Interrupt queued D0229 20:26:50.828380 59450 task_block.go:223] [ 38] Interrupt queued D0229 20:26:50.828433 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller130508299]} D0229 20:26:50.829781 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] 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: 253, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583008010, NanoSec: 377763553}, MTime: {Sec: 1583008010, NanoSec: 377763553}, CTime: {Sec: 1583008010, NanoSec: 377763553}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384224}]} D0229 20:26:50.830060 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller130508299, Size: 1} D0229 20:26:50.830665 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.831084 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 20:26:50.831973 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384224}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 253, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583008010, NanoSec: 377763553}, MTime: {Sec: 1583008010, NanoSec: 377763553}, CTime: {Sec: 1583008010, NanoSec: 377763553}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 20:26:50.832217 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalk{FID: 7, NewFID: 8, Names: []} D0229 20:26:50.832745 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rwalk{QIDs: []} D0229 20:26:50.832914 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tlopen{FID: 8, Flags: ReadOnly} D0229 20:26:50.833807 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384224}, IoUnit: 0, File: &{{30}}} D0229 20:26:50.835057 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 20:26:50.835942 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384224}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 253, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1583008010, NanoSec: 377763553}, MTime: {Sec: 1583008010, NanoSec: 377763553}, CTime: {Sec: 1583008010, NanoSec: 377763553}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/02/29 20:26:50 parsed 1 programs I0229 20:26:50.847127 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.847392 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.847488 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.847601 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.847723 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 20:26:50.847865 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.847947 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.848189 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.848291 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.848453 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.848539 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.848611 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.848829 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:50.848844 59450 task_stop.go:118] [ 30] Entering internal stop (*kernel.vforkStop)(nil) D0229 20:26:50.848953 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:50.849716 59450 task_block.go:223] [ 39] Interrupt queued D0229 20:26:50.855906 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0229 20:26:50.857839 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] 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: 1583007929, NanoSec: 617850322}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384257}]} D0229 20:26:50.858213 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0229 20:26:50.858716 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.859058 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 20:26:50.860066 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384257}, 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: 1583007929, NanoSec: 617850322}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 20:26:50.860297 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalk{FID: 9, NewFID: 10, Names: []} D0229 20:26:50.861112 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rwalk{QIDs: []} D0229 20:26:50.861337 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tlopen{FID: 10, Flags: ReadOnly} D0229 20:26:50.862265 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384257}, IoUnit: 0, File: &{{31}}} I0229 20:26:50.862549 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.862723 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.862817 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.862952 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.863156 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.863342 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.863692 59450 syscalls.go:266] [ 39] Allocating stack with size of 8388608 bytes D0229 20:26:50.864866 59450 task_stop.go:137] [ 30] Leaving internal stop (*kernel.vforkStop)(nil) I0229 20:26:50.882846 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.883098 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.883238 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.883307 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.883497 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.883602 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.888652 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0229 20:26:50.889412 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.889590 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 20:26:50.890125 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.891349 59450 task_exit.go:221] [ 39] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:50.892858 59450 task_exit.go:221] [ 39] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:50.893059 59450 task_signals.go:446] [ 22] Notified of signal 17 D0229 20:26:50.893254 59450 task_block.go:223] [ 22] Interrupt queued D0229 20:26:50.893219 59450 task_block.go:223] [ 22] Interrupt queued D0229 20:26:50.893566 59450 task_signals.go:176] [ 22] Not restarting syscall 202 after errno 516: interrupted by signal 17 D0229 20:26:50.893680 59450 task_signals.go:220] [ 22] Signal 17: delivering to handler D0229 20:26:50.893804 59450 task_exit.go:221] [ 39] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:50.895519 59450 task_block.go:223] [ 40] Interrupt queued D0229 20:26:50.898988 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0229 20:26:50.900094 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] 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: 1583007929, NanoSec: 617850322}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384257}]} D0229 20:26:50.900275 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tclunk{FID: 11} D0229 20:26:50.900759 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rclunk{} D0229 20:26:50.901017 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 20:26:50.902084 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384257}, 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: 1583007929, NanoSec: 617850322}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/02/29 20:26:50 executed programs: 0 I0229 20:26:50.908168 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.908614 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.908796 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.908847 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.910475 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 20:26:50.910584 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.910646 59450 task_stop.go:118] [ 27] Entering internal stop (*kernel.vforkStop)(nil) D0229 20:26:50.910732 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.910673 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.910816 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:50.910968 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.911061 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:50.911235 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.911327 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:50.911352 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.911487 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:50.911577 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:50.911563 59450 task_block.go:223] [ 41] Interrupt queued D0229 20:26:50.919084 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0229 20:26:50.920265 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] 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: 1583007929, NanoSec: 617850322}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384257}]} D0229 20:26:50.920443 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tclunk{FID: 11} D0229 20:26:50.920918 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rclunk{} D0229 20:26:50.921203 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 20:26:50.922131 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384257}, 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: 1583007929, NanoSec: 617850322}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 20:26:50.923339 59450 syscalls.go:266] [ 41] Allocating stack with size of 8388608 bytes D0229 20:26:50.924276 59450 task_stop.go:137] [ 27] Leaving internal stop (*kernel.vforkStop)(nil) D0229 20:26:50.931925 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0229 20:26:50.932640 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.932796 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 20:26:50.933488 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} I0229 20:26:50.943415 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.943607 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.943731 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.943893 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.944041 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.944229 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:50.944577 59450 task_block.go:223] [ 42] Interrupt queued D0229 20:26:50.951199 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.975584 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.975865 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.977262 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.977771 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.978335 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.978591 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.979175 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.979822 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.980365 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.980513 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.981040 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.981542 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.982048 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.982247 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.982721 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.983065 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.983586 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.983740 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.984162 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.984687 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.985206 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.985424 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.985950 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.986333 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.986809 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.986951 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.987388 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.987727 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.988096 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.988221 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.988596 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:50.989065 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:50.989475 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:50.989629 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:50.990148 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} I0229 20:26:50.991092 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:50.991317 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:50.991544 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.991612 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:50.991795 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:50.991933 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.011305 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.011548 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.011705 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.011760 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.012028 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.012164 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.020050 59450 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 20:26:51.020161 59450 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 0 D0229 20:26:51.020309 59450 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 0 D0229 20:26:51.020383 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.020465 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.020949 59450 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 20:26:51.021018 59450 netfilter.go:54] netfilter: convert to binary: found hook 2 at offset 152 D0229 20:26:51.021130 59450 netfilter.go:54] netfilter: convert to binary: found underflow 2 at offset 152 D0229 20:26:51.021200 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.021295 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.021772 59450 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 20:26:51.021843 59450 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0229 20:26:51.021962 59450 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0229 20:26:51.022042 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.022127 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.022624 59450 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0229 20:26:51.022744 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0229 20:26:51.023226 59450 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0229 20:26:51.023305 59450 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 20:26:51.023390 59450 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0229 20:26:51.023452 59450 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0229 20:26:51.023525 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.023580 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.024163 59450 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 20:26:51.024226 59450 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 152 D0229 20:26:51.024312 59450 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 152 D0229 20:26:51.024390 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.024451 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.024886 59450 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 20:26:51.024973 59450 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0229 20:26:51.025038 59450 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0229 20:26:51.025103 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.025158 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.025588 59450 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0229 20:26:51.025652 59450 netfilter.go:54] netfilter: convert to binary: found hook 4 at offset 456 D0229 20:26:51.025719 59450 netfilter.go:54] netfilter: convert to binary: found underflow 4 at offset 456 D0229 20:26:51.025772 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.025852 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.026372 59450 netfilter.go:54] netfilter: convert to binary: current offset: 608 D0229 20:26:51.026466 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0229 20:26:51.027006 59450 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0229 20:26:51.027087 59450 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 20:26:51.027156 59450 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0229 20:26:51.027213 59450 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0229 20:26:51.027265 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.027332 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.027772 59450 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 20:26:51.027860 59450 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 152 D0229 20:26:51.027953 59450 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 152 D0229 20:26:51.028020 59450 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 20:26:51.028091 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:152 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[40 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 254 255 255 255 0 0 0 0]} D0229 20:26:51.028591 59450 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 20:26:51.028755 59450 netfilter.go:54] netfilter: convert to binary: adding entry: {IPTEntry:{IP:{Src:[0 0 0 0] Dst:[0 0 0 0] SrcMask:[0 0 0 0] DstMask:[0 0 0 0] InputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterface:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] InputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] OutputInterfaceMask:[0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0] Protocol:0 Flags:0 InverseFlags:0} NFCache:0 TargetOffset:112 NextOffset:176 Comeback:0 Counters:{Pcnt:0 Bcnt:0}} Elems:[64 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 69 82 82 79 82 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0]} D0229 20:26:51.029503 59450 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 I0229 20:26:51.031707 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.031947 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.032098 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.032254 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.032427 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.032572 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.051700 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.051921 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.052047 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.052161 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.052399 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.052650 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.064696 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.064976 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.065090 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.065151 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:51.065495 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.065641 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.065587 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.066956 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.065733 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:51.067132 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.067272 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:51.067564 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:51.067674 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:51.067807 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.068059 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:51.068252 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 20:26:51.081957 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.082168 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.082284 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.082404 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.082646 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.082798 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.102171 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.102396 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.102553 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.102650 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.102859 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.103014 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.122380 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.122549 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.122662 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.122711 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.122888 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.123021 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.142641 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.142820 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.142923 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.142984 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.143267 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.143406 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.162844 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.163040 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.163210 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.163308 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.163559 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.163747 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.183112 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.183392 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.183539 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.183581 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.183812 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.183961 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.213453 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.213717 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.213886 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.213997 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.214199 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.214363 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.229297 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.229566 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.229728 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.229771 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.229964 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.230095 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 20:26:51.249558 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.249744 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.249851 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.249896 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.250164 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.250283 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.262607 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.263360 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.263579 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.264186 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.264605 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.265123 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.265242 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.265667 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.266009 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.266617 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.266725 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.267356 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.267670 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.268293 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.268504 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.268983 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.269315 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.269859 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.269986 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} I0229 20:26:51.270192 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.270361 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.270469 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.270537 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.270591 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.270747 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.270869 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.270991 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.271581 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.271725 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.272217 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.272531 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.273077 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.273221 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.273742 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.274132 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.274671 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.274827 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.275239 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.275619 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.276287 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.276462 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.277056 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.277428 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.277890 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.278063 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.278553 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.296533 59450 task_block.go:223] [ 43] Interrupt queued D0229 20:26:51.306828 59450 task_block.go:223] [ 44] Interrupt queued D0229 20:26:51.328899 59450 task_block.go:223] [ 45] Interrupt queued D0229 20:26:51.337852 59450 parameters.go:238] Clock(Monotonic): error: 43 ns, adjusted frequency from 2299774291 Hz to 2299774713 Hz D0229 20:26:51.338067 59450 parameters.go:238] Clock(Realtime): error: -219 ns, adjusted frequency from 2299775202 Hz to 2299774200 Hz D0229 20:26:51.338146 59450 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8969015466659980 monotonicBaseRef:83000242984 monotonicFrequency:2299774713 realtimeReady:1 realtimeBaseCycles:8969015467166514 realtimeBaseRef:1583008011338062185 realtimeFrequency:2299774200} I0229 20:26:51.339633 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.339915 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.340313 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.340451 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:51.343552 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.343588 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.343788 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.343910 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.344036 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:51.344224 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.344357 59450 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 20:26:51.344498 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:51.344521 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:51.344672 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.344983 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:51.345124 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:51.346845 59450 task_block.go:223] [ 44] Interrupt queued D0229 20:26:51.347046 59450 task_block.go:223] [ 45] Interrupt queued D0229 20:26:51.347007 59450 task_block.go:223] [ 44] Interrupt queued D0229 20:26:51.347159 59450 task_exit.go:221] [ 43] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.347214 59450 task_block.go:223] [ 45] Interrupt queued D0229 20:26:51.347377 59450 task_exit.go:221] [ 43] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.347451 59450 task_signals.go:189] [ 44] Signal 9: terminating thread group D0229 20:26:51.347462 59450 task_signals.go:189] [ 45] Signal 9: terminating thread group I0229 20:26:51.347643 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 43, TID: 44, fault addr: 0x0 D0229 20:26:51.347953 59450 task_exit.go:221] [ 44] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 20:26:51.347954 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 43, TID: 45, fault addr: 0x0 D0229 20:26:51.348212 59450 task_exit.go:221] [ 44] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.348318 59450 task_exit.go:221] [ 44] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.348504 59450 task_exit.go:221] [ 45] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.350603 59450 task_exit.go:221] [ 45] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.350775 59450 task_exit.go:221] [ 45] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.351026 59450 task_signals.go:419] [ 42] Discarding ignored signal 17 D0229 20:26:51.353633 59450 task_exit.go:221] [ 43] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.359430 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.360974 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.361178 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.361657 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.362850 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.363456 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.363643 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.364173 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.365431 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.366058 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.366225 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.366820 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} I0229 20:26:51.369902 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.370139 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.370273 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.370330 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.370599 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.370773 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.377303 59450 task_block.go:223] [ 46] Interrupt queued D0229 20:26:51.389679 59450 task_block.go:223] [ 47] Interrupt queued I0229 20:26:51.390157 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.390411 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.390570 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.390617 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.390840 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.390967 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.411108 59450 task_block.go:223] [ 48] Interrupt queued D0229 20:26:51.423212 59450 task_block.go:223] [ 47] Interrupt queued D0229 20:26:51.423330 59450 task_block.go:223] [ 47] Interrupt queued D0229 20:26:51.423428 59450 task_block.go:223] [ 48] Interrupt queued D0229 20:26:51.423458 59450 task_block.go:223] [ 48] Interrupt queued D0229 20:26:51.423670 59450 task_exit.go:221] [ 46] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.423858 59450 task_signals.go:189] [ 47] Signal 9: terminating thread group D0229 20:26:51.423951 59450 task_exit.go:221] [ 46] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.423934 59450 task_signals.go:189] [ 48] Signal 9: terminating thread group I0229 20:26:51.424164 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 46, TID: 48, fault addr: 0x0 D0229 20:26:51.424332 59450 task_exit.go:221] [ 48] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 20:26:51.424323 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 46, TID: 47, fault addr: 0x0 D0229 20:26:51.424485 59450 task_exit.go:221] [ 47] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.424749 59450 task_exit.go:221] [ 47] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.424877 59450 task_exit.go:221] [ 47] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.427756 59450 task_exit.go:221] [ 48] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.427874 59450 task_exit.go:221] [ 48] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.428091 59450 task_signals.go:419] [ 42] Discarding ignored signal 17 D0229 20:26:51.428717 59450 task_exit.go:221] [ 46] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.432193 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.432925 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.433214 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.433765 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.434498 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.435126 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.435295 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.435852 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.436557 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.437087 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.437241 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.437859 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.443790 59450 task_block.go:223] [ 49] Interrupt queued I0229 20:26:51.447282 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.447480 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.447622 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.447665 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.447843 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.447971 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.453858 59450 task_block.go:223] [ 50] Interrupt queued D0229 20:26:51.462827 59450 task_block.go:223] [ 51] Interrupt queued D0229 20:26:51.466823 59450 task_block.go:223] [ 50] Interrupt queued D0229 20:26:51.466971 59450 task_block.go:223] [ 50] Interrupt queued D0229 20:26:51.467021 59450 task_block.go:223] [ 51] Interrupt queued D0229 20:26:51.467177 59450 task_exit.go:221] [ 49] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.467133 59450 task_block.go:223] [ 51] Interrupt queued D0229 20:26:51.467363 59450 task_exit.go:221] [ 49] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.467470 59450 task_signals.go:189] [ 51] Signal 9: terminating thread group D0229 20:26:51.467173 59450 task_signals.go:189] [ 50] Signal 9: terminating thread group I0229 20:26:51.467602 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 49, TID: 51, fault addr: 0x0 D0229 20:26:51.467773 59450 task_exit.go:221] [ 51] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 20:26:51.467872 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 49, TID: 50, fault addr: 0x0 D0229 20:26:51.467936 59450 task_exit.go:221] [ 51] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.468059 59450 task_exit.go:221] [ 51] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.468242 59450 task_exit.go:221] [ 50] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.469515 59450 task_exit.go:221] [ 50] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.469660 59450 task_exit.go:221] [ 50] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.469897 59450 task_signals.go:419] [ 42] Discarding ignored signal 17 D0229 20:26:51.471092 59450 task_exit.go:221] [ 49] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.473109 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.473730 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.473909 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.474379 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.475093 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.475652 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.475788 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.476248 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.476876 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.477490 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.477629 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.478166 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.484378 59450 task_block.go:223] [ 52] Interrupt queued I0229 20:26:51.487677 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.487911 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.488092 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.488152 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.488389 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.488535 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.493453 59450 task_block.go:223] [ 53] Interrupt queued D0229 20:26:51.500335 59450 task_block.go:223] [ 54] Interrupt queued D0229 20:26:51.504396 59450 task_block.go:223] [ 53] Interrupt queued D0229 20:26:51.504546 59450 task_block.go:223] [ 54] Interrupt queued D0229 20:26:51.504549 59450 task_block.go:223] [ 53] Interrupt queued D0229 20:26:51.504639 59450 task_exit.go:221] [ 52] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.504720 59450 task_block.go:223] [ 54] Interrupt queued D0229 20:26:51.504862 59450 task_exit.go:221] [ 52] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.504899 59450 task_signals.go:189] [ 54] Signal 9: terminating thread group D0229 20:26:51.504942 59450 task_signals.go:189] [ 53] Signal 9: terminating thread group I0229 20:26:51.505053 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 52, TID: 54, fault addr: 0x0 D0229 20:26:51.505291 59450 task_exit.go:221] [ 54] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.505428 59450 task_exit.go:221] [ 54] Transitioning from exit state TaskExitInitiated to TaskExitZombie I0229 20:26:51.505415 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 52, TID: 53, fault addr: 0x0 D0229 20:26:51.505536 59450 task_exit.go:221] [ 54] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.505756 59450 task_exit.go:221] [ 53] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.507051 59450 task_exit.go:221] [ 53] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.507168 59450 task_exit.go:221] [ 53] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.507311 59450 task_signals.go:419] [ 42] Discarding ignored signal 17 D0229 20:26:51.507524 59450 task_exit.go:221] [ 52] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.511654 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.512317 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.512519 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.513101 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.513776 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.514332 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.514485 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.515029 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.516001 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.517268 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.517529 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.518410 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.525018 59450 task_block.go:223] [ 55] Interrupt queued I0229 20:26:51.528070 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.528255 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.528375 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.528447 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.528726 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.528901 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.534543 59450 task_block.go:223] [ 56] Interrupt queued D0229 20:26:51.545326 59450 task_block.go:223] [ 57] Interrupt queued D0229 20:26:51.550160 59450 task_block.go:223] [ 56] Interrupt queued D0229 20:26:51.550214 59450 task_block.go:223] [ 56] Interrupt queued D0229 20:26:51.550299 59450 task_block.go:223] [ 57] Interrupt queued D0229 20:26:51.550329 59450 task_block.go:223] [ 57] Interrupt queued D0229 20:26:51.550478 59450 task_exit.go:221] [ 55] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.550626 59450 task_signals.go:189] [ 57] Signal 9: terminating thread group D0229 20:26:51.550642 59450 task_exit.go:221] [ 55] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.550739 59450 task_signals.go:189] [ 56] Signal 9: terminating thread group I0229 20:26:51.550891 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 55, TID: 57, fault addr: 0x0 D0229 20:26:51.551053 59450 task_exit.go:221] [ 57] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.551241 59450 task_exit.go:221] [ 57] Transitioning from exit state TaskExitInitiated to TaskExitZombie I0229 20:26:51.551129 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 55, TID: 56, fault addr: 0x0 D0229 20:26:51.551323 59450 task_exit.go:221] [ 57] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.551558 59450 task_exit.go:221] [ 56] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.552975 59450 task_exit.go:221] [ 56] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.553123 59450 task_exit.go:221] [ 56] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.553288 59450 task_signals.go:419] [ 42] Discarding ignored signal 17 D0229 20:26:51.555146 59450 task_exit.go:221] [ 55] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.559416 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.560163 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.560371 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.560998 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.561995 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.562550 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.562701 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.563188 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.564216 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.564718 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.564828 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} I0229 20:26:51.565399 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.566002 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.568131 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.568161 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.568256 59450 task_block.go:223] [ 1] Interrupt queued I0229 20:26:51.568399 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.568500 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.568577 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.568686 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.568727 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.569270 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:51.569340 59450 task_block.go:223] [ 2] Interrupt queued D0229 20:26:51.569401 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.569600 59450 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 20:26:51.569715 59450 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 20:26:51.575142 59450 task_block.go:223] [ 58] Interrupt queued D0229 20:26:51.582948 59450 task_block.go:223] [ 59] Interrupt queued D0229 20:26:51.597213 59450 task_block.go:223] [ 60] Interrupt queued D0229 20:26:51.608889 59450 task_block.go:223] [ 59] Interrupt queued D0229 20:26:51.608938 59450 task_block.go:223] [ 59] Interrupt queued D0229 20:26:51.609123 59450 task_block.go:223] [ 60] Interrupt queued D0229 20:26:51.609265 59450 task_block.go:223] [ 60] Interrupt queued D0229 20:26:51.609268 59450 task_exit.go:221] [ 58] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.609484 59450 task_signals.go:189] [ 60] Signal 9: terminating thread group D0229 20:26:51.609597 59450 task_exit.go:221] [ 58] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.609536 59450 task_signals.go:189] [ 59] Signal 9: terminating thread group I0229 20:26:51.609799 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 58, TID: 60, fault addr: 0x0 D0229 20:26:51.609997 59450 task_exit.go:221] [ 60] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 20:26:51.610080 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 58, TID: 59, fault addr: 0x0 D0229 20:26:51.610205 59450 task_exit.go:221] [ 60] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.610317 59450 task_exit.go:221] [ 60] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.610565 59450 task_exit.go:221] [ 59] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.611975 59450 task_exit.go:221] [ 59] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.612137 59450 task_exit.go:221] [ 59] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.612303 59450 task_signals.go:419] [ 42] Discarding ignored signal 17 D0229 20:26:51.613784 59450 task_exit.go:221] [ 58] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.617336 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.617987 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.618229 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.618731 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.619563 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.620120 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.620284 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.620839 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.621386 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.621927 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.622073 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.622869 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.628188 59450 task_block.go:223] [ 61] Interrupt queued I0229 20:26:51.629096 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.629281 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.629396 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.629505 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.629689 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.629856 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.639233 59450 task_block.go:223] [ 62] Interrupt queued D0229 20:26:51.647551 59450 task_block.go:223] [ 63] Interrupt queued D0229 20:26:51.652056 59450 task_block.go:223] [ 62] Interrupt queued D0229 20:26:51.652091 59450 task_block.go:223] [ 62] Interrupt queued D0229 20:26:51.652187 59450 task_block.go:223] [ 63] Interrupt queued D0229 20:26:51.652280 59450 task_block.go:223] [ 63] Interrupt queued D0229 20:26:51.652284 59450 task_signals.go:189] [ 62] Signal 9: terminating thread group D0229 20:26:51.652389 59450 task_exit.go:221] [ 61] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.652666 59450 task_signals.go:189] [ 63] Signal 9: terminating thread group D0229 20:26:51.652760 59450 task_exit.go:221] [ 61] Transitioning from exit state TaskExitInitiated to TaskExitZombie I0229 20:26:51.652743 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 61, TID: 62, fault addr: 0x0 D0229 20:26:51.653015 59450 task_exit.go:221] [ 62] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 20:26:51.652997 59450 compat.go:129] Uncaught signal: "killed" (9), PID: 61, TID: 63, fault addr: 0x0 D0229 20:26:51.653199 59450 task_exit.go:221] [ 62] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.653359 59450 task_exit.go:221] [ 62] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.653567 59450 task_exit.go:221] [ 63] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 20:26:51.655102 59450 task_exit.go:221] [ 63] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 20:26:51.655400 59450 task_exit.go:221] [ 63] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.655620 59450 task_signals.go:419] [ 42] Discarding ignored signal 17 D0229 20:26:51.656322 59450 task_exit.go:221] [ 61] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 20:26:51.658483 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.659066 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.659214 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.659763 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.660696 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.661220 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.661415 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.661943 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.662588 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 20:26:51.663119 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 2} D0229 20:26:51.663228 59450 transport_flipcall.go:127] send [channel @0xc0004d03c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 20:26:51.663752 59450 transport_flipcall.go:234] recv [channel @0xc0004d03c0] Rlerror{Error: 95} D0229 20:26:51.669061 59450 task_block.go:223] [ 64] Interrupt queued I0229 20:26:51.669542 59450 loader.go:566] Received external signal 23, mode: Process D0229 20:26:51.669759 59450 task_signals.go:446] [ 1] Notified of signal 23 D0229 20:26:51.669951 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.670076 59450 task_block.go:223] [ 1] Interrupt queued D0229 20:26:51.670339 59450 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 20:26:51.670502 59450 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 20:26:51.677879 59450 task_block.go:223] [ 65] Interrupt queued D0229 20:26:51.686508 59450 task_block.go:223] [ 66] Interrupt queued ================== WARNING: DATA RACE Write at 0x00c0002ecb50 by goroutine 374: gvisor.dev/gvisor/pkg/tcpip/transport/udp.(*endpoint).Connect() pkg/tcpip/transport/udp/endpoint.go:1053 +0x46a 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 DIAGNOSIS: I0229 20:26:51.719348 64098 main.go:305] *************************** I0229 20:26:51.719454 64098 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-0] I0229 20:26:51.719653 64098 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 20:26:51.719731 64098 main.go:308] PID: 64098 I0229 20:26:51.719828 64098 main.go:309] UID: 0, GID: 0 I0229 20:26:51.719915 64098 main.go:310] Configuration: I0229 20:26:51.719981 64098 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 20:26:51.720050 64098 main.go:312] Platform: ptrace I0229 20:26:51.720166 64098 main.go:313] FileAccess: shared, overlay: false I0229 20:26:51.720254 64098 main.go:314] Network: sandbox, logging: false I0229 20:26:51.720325 64098 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 20:26:51.720415 64098 main.go:316] *************************** W0229 20:26:51.720485 64098 main.go:321] Block the TERM signal. This is only safe in tests! D0229 20:26:51.720682 64098 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.726701 64098 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0229 20:26:51.726872 64098 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.726955 64098 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.727439 64098 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 20:26:51.816742 64098 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 59450 I0229 20:26:51.816896 64098 debug.go:131] Retrieving sandbox stacks D0229 20:26:51.817029 64098 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.817150 64098 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0229 20:26:51.817355 64098 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 59450: connection refused retrieving stacks: connecting to control server at PID 59450: connection refused W0229 20:26:51.817785 64098 main.go:338] Failure to execute command, err: 1 Error collecting stacks: failed to run ["/syzkaller/managers/ptrace-proxy-sandbox-race/current/image" "-root" "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "-watchdog-action=panic" "-network=none" "-debug" "-alsologtostderr" "-platform=ptrace" "-file-access=shared" "-network=sandbox" "-TESTONLY-unsafe-nonroot" "debug" "-stacks" "--ps" "ci-gvisor-ptrace-proxy-sandbox-race-0"]: exit status 128 I0229 20:26:51.719348 64098 main.go:305] *************************** I0229 20:26:51.719454 64098 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-0] I0229 20:26:51.719653 64098 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 20:26:51.719731 64098 main.go:308] PID: 64098 I0229 20:26:51.719828 64098 main.go:309] UID: 0, GID: 0 I0229 20:26:51.719915 64098 main.go:310] Configuration: I0229 20:26:51.719981 64098 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 20:26:51.720050 64098 main.go:312] Platform: ptrace I0229 20:26:51.720166 64098 main.go:313] FileAccess: shared, overlay: false I0229 20:26:51.720254 64098 main.go:314] Network: sandbox, logging: false I0229 20:26:51.720325 64098 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 20:26:51.720415 64098 main.go:316] *************************** W0229 20:26:51.720485 64098 main.go:321] Block the TERM signal. This is only safe in tests! D0229 20:26:51.720682 64098 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.726701 64098 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0229 20:26:51.726872 64098 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.726955 64098 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.727439 64098 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 20:26:51.816742 64098 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 59450 I0229 20:26:51.816896 64098 debug.go:131] Retrieving sandbox stacks D0229 20:26:51.817029 64098 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.817150 64098 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0229 20:26:51.817355 64098 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 59450: connection refused retrieving stacks: connecting to control server at PID 59450: connection refused W0229 20:26:51.817785 64098 main.go:338] Failure to execute command, err: 1 Previous read at 0x00c0002ecb50 by goroutine 355: gvisor.dev/gvisor/pkg/tcpip/stack.(*TransportEndpointInfo).AddrNetProto() pkg/tcpip/stack/stack.go:573 +0x79 gvisor.dev/gvisor/pkg/tcpip/transport/udp.(*endpoint).checkV4Mapped() pkg/tcpip/transport/udp/endpoint.go:931 +0xee gvisor.dev/gvisor/pkg/tcpip/transport/udp.(*endpoint).Connect() pkg/tcpip/transport/udp/endpoint.go:984 +0x6c 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 Goroutine 374 (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 355 (running) created at: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start() pkg/sentry/kernel/task_start.go:315 +0x19d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Clone() pkg/sentry/kernel/task_clone.go:361 +0x1297 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.clone() pkg/sentry/syscalls/linux/sys_thread.go:226 +0x171 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Clone() pkg/sentry/syscalls/linux/sys_clone_amd64.go:34 +0x80 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall() pkg/sentry/kernel/task_syscall.go:170 +0x44d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke() pkg/sentry/kernel/task_syscall.go:291 +0xb4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter() pkg/sentry/kernel/task_syscall.go:252 +0x109 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall() pkg/sentry/kernel/task_syscall.go:227 +0x1b3 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute() pkg/sentry/kernel/task_run.go:232 +0x1aaa gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run() pkg/sentry/kernel/task_run.go:92 +0x320 ================== W0229 20:26:51.808223 63920 error.go:48] FATAL ERROR: waiting on pid 22: waiting on PID 22 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 22: waiting on PID 22 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0": urpc method "containerManager.WaitPID" failed: EOF W0229 20:26:51.808831 63920 main.go:338] Failure to execute command, err: 1 W0229 20:26:51.816915 59442 sandbox.go:742] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-0" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D0229 20:26:51.817379 59442 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.817572 59442 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.817708 59442 sandbox.go:1058] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-0" by destroying sandbox D0229 20:26:51.817880 59442 sandbox.go:788] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0229 20:26:51.818013 59442 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 59449 I0229 20:26:51.919945 59442 main.go:329] Exiting with status: 16896