D0229 08:47:23.787437 2294 parameters.go:238] Clock(Monotonic): error: 376 ns, adjusted frequency from 2299773515 Hz to 2299774612 Hz D0229 08:47:23.787753 2294 parameters.go:238] Clock(Realtime): error: 223 ns, adjusted frequency from 2299773849 Hz to 2299774850 Hz D0229 08:47:23.788037 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872499558916276 monotonicBaseRef:2000296542 monotonicFrequency:2299774612 realtimeReady:1 realtimeBaseCycles:8872499559679610 realtimeBaseRef:1582966043787745338 realtimeFrequency:2299774850} I0229 08:47:24.139818 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:24.140039 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:24.140146 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:24.140235 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:24.140529 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:24.140758 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:24.787415 2294 parameters.go:238] Clock(Monotonic): error: 594 ns, adjusted frequency from 2299774612 Hz to 2299775487 Hz D0229 08:47:24.787689 2294 parameters.go:238] Clock(Realtime): error: 279 ns, adjusted frequency from 2299774850 Hz to 2299774988 Hz I0229 08:47:24.787643 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:24.787941 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:24.787844 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872501858656480 monotonicBaseRef:3000281580 monotonicFrequency:2299775487 realtimeReady:1 realtimeBaseCycles:8872501859312769 realtimeBaseRef:1582966044787683727 realtimeFrequency:2299774988} D0229 08:47:24.788055 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:24.788102 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:24.788365 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:24.788506 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:25.787463 2294 parameters.go:238] Clock(Monotonic): error: 41 ns, adjusted frequency from 2299775487 Hz to 2299774313 Hz D0229 08:47:25.787720 2294 parameters.go:238] Clock(Realtime): error: 52 ns, adjusted frequency from 2299774988 Hz to 2299774597 Hz D0229 08:47:25.787865 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872504158508229 monotonicBaseRef:4000314740 monotonicFrequency:2299774313 realtimeReady:1 realtimeBaseCycles:8872504159151419 realtimeBaseRef:1582966045787711408 realtimeFrequency:2299774597} D0229 08:47:26.787443 2294 parameters.go:238] Clock(Monotonic): error: -72 ns, adjusted frequency from 2299774313 Hz to 2299774103 Hz I0229 08:47:26.787604 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:26.787704 2294 parameters.go:238] Clock(Realtime): error: 25 ns, adjusted frequency from 2299774597 Hz to 2299774437 Hz D0229 08:47:26.787863 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:26.787953 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872506458235391 monotonicBaseRef:5000294237 monotonicFrequency:2299774103 realtimeReady:1 realtimeBaseCycles:8872506458885845 realtimeBaseRef:1582966046787693940 realtimeFrequency:2299774437} D0229 08:47:26.788070 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:26.788114 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:26.788235 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:26.788369 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:26.788545 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:26.788739 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:27.787488 2294 parameters.go:238] Clock(Monotonic): error: 356 ns, adjusted frequency from 2299774103 Hz to 2299775134 Hz I0229 08:47:27.787623 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:27.787773 2294 parameters.go:238] Clock(Realtime): error: 489 ns, adjusted frequency from 2299774437 Hz to 2299775583 Hz D0229 08:47:27.787808 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:27.788050 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:27.788079 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:27.787936 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872508758134339 monotonicBaseRef:6000348522 monotonicFrequency:2299775134 realtimeReady:1 realtimeBaseCycles:8872508758825667 realtimeBaseRef:1582966047787765853 realtimeFrequency:2299775583} I0229 08:47:27.788223 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:27.788349 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:27.788345 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:27.788509 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:27.788430 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:27.788891 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:27.788999 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:27.789028 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:27.789213 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:27.789337 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:47:28.140079 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:28.140309 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:28.140419 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:28.140548 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:28.140647 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:28.140703 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:28.140942 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:28.141104 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:28.787437 2294 parameters.go:238] Clock(Monotonic): error: 194 ns, adjusted frequency from 2299775134 Hz to 2299774778 Hz D0229 08:47:28.787640 2294 parameters.go:238] Clock(Realtime): error: -270 ns, adjusted frequency from 2299775583 Hz to 2299773842 Hz D0229 08:47:28.787783 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872511057796162 monotonicBaseRef:7000299251 monotonicFrequency:2299774778 realtimeReady:1 realtimeBaseCycles:8872511058299594 realtimeBaseRef:1582966048787634685 realtimeFrequency:2299773842} D0229 08:47:29.787439 2294 parameters.go:238] Clock(Monotonic): error: 401 ns, adjusted frequency from 2299774778 Hz to 2299775356 Hz D0229 08:47:29.787644 2294 parameters.go:238] Clock(Realtime): error: 142 ns, adjusted frequency from 2299773842 Hz to 2299774841 Hz D0229 08:47:29.787774 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872513357525605 monotonicBaseRef:8000279538 monotonicFrequency:2299775356 realtimeReady:1 realtimeBaseCycles:8872513358082346 realtimeBaseRef:1582966049787638559 realtimeFrequency:2299774841} D0229 08:47:30.787500 2294 parameters.go:238] Clock(Monotonic): error: -614 ns, adjusted frequency from 2299775356 Hz to 2299773092 Hz D0229 08:47:30.787774 2294 parameters.go:238] Clock(Realtime): error: -294 ns, adjusted frequency from 2299774841 Hz to 2299773861 Hz I0229 08:47:30.787717 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:30.787900 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872515657495510 monotonicBaseRef:9000364132 monotonicFrequency:2299773092 realtimeReady:1 realtimeBaseCycles:8872515658154611 realtimeBaseRef:1582966050787767886 realtimeFrequency:2299773861} D0229 08:47:30.788027 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:30.788223 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:30.788259 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:30.788444 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:30.788483 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:30.788582 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:30.788589 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:30.788729 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:30.789044 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:30.789175 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:30.789175 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:30.789408 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:30.789533 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:47:31.140147 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:31.140370 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:31.140487 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:31.140598 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:31.140772 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:31.140892 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:31.787416 2294 parameters.go:238] Clock(Monotonic): error: 278 ns, adjusted frequency from 2299773092 Hz to 2299775250 Hz I0229 08:47:31.787510 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:31.787613 2294 parameters.go:238] Clock(Realtime): error: 544 ns, adjusted frequency from 2299773861 Hz to 2299775859 Hz D0229 08:47:31.787688 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:31.787908 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:31.787789 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872517957078349 monotonicBaseRef:10000281405 monotonicFrequency:2299775250 realtimeReady:1 realtimeBaseCycles:8872517957556677 realtimeBaseRef:1582966051787606220 realtimeFrequency:2299775859} D0229 08:47:31.787934 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:31.788171 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:31.788312 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:32.787415 2294 parameters.go:238] Clock(Monotonic): error: 524 ns, adjusted frequency from 2299775250 Hz to 2299775856 Hz D0229 08:47:32.787685 2294 parameters.go:238] Clock(Realtime): error: -197 ns, adjusted frequency from 2299775859 Hz to 2299774147 Hz D0229 08:47:32.787903 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872520256847341 monotonicBaseRef:11000278683 monotonicFrequency:2299775856 realtimeReady:1 realtimeBaseCycles:8872520257495956 realtimeBaseRef:1582966052787677279 realtimeFrequency:2299774147} I0229 08:47:33.167057 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:33.167286 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:33.167443 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:33.167603 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:33.167868 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:33.168023 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:33.787941 2294 parameters.go:238] Clock(Monotonic): error: -239 ns, adjusted frequency from 2299775856 Hz to 2299774010 Hz D0229 08:47:33.788208 2294 parameters.go:238] Clock(Realtime): error: 231 ns, adjusted frequency from 2299774147 Hz to 2299775147 Hz D0229 08:47:33.788374 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872522557717134 monotonicBaseRef:12000754354 monotonicFrequency:2299774010 realtimeReady:1 realtimeBaseCycles:8872522558461790 realtimeBaseRef:1582966053788195454 realtimeFrequency:2299775147} I0229 08:47:34.140135 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:34.140334 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:34.140427 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:34.140539 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:34.140735 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:34.140847 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:34.787406 2294 parameters.go:238] Clock(Monotonic): error: -184 ns, adjusted frequency from 2299774010 Hz to 2299774146 Hz D0229 08:47:34.787643 2294 parameters.go:238] Clock(Realtime): error: -252 ns, adjusted frequency from 2299775147 Hz to 2299774003 Hz D0229 08:47:34.787733 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872524856383638 monotonicBaseRef:13000272782 monotonicFrequency:2299774146 realtimeReady:1 realtimeBaseCycles:8872524856953527 realtimeBaseRef:1582966054787637395 realtimeFrequency:2299774003} I0229 08:47:35.140088 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:35.140269 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:35.140370 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:35.140500 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:35.140637 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:35.140755 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:35.787435 2294 parameters.go:238] Clock(Monotonic): error: 8 ns, adjusted frequency from 2299774146 Hz to 2299774638 Hz D0229 08:47:35.787670 2294 parameters.go:238] Clock(Realtime): error: -276 ns, adjusted frequency from 2299774003 Hz to 2299774036 Hz D0229 08:47:35.787828 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872527156222573 monotonicBaseRef:14000300953 monotonicFrequency:2299774638 realtimeReady:1 realtimeBaseCycles:8872527156789419 realtimeBaseRef:1582966055787664305 realtimeFrequency:2299774036} D0229 08:47:36.787437 2294 parameters.go:238] Clock(Monotonic): error: -80 ns, adjusted frequency from 2299774638 Hz to 2299774528 Hz D0229 08:47:36.787606 2294 parameters.go:238] Clock(Realtime): error: 211 ns, adjusted frequency from 2299774036 Hz to 2299775106 Hz D0229 08:47:36.787777 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872529455997989 monotonicBaseRef:15000301291 monotonicFrequency:2299774528 realtimeReady:1 realtimeBaseCycles:8872529456418219 realtimeBaseRef:1582966056787601152 realtimeFrequency:2299775106} D0229 08:47:37.787456 2294 parameters.go:238] Clock(Monotonic): error: 206 ns, adjusted frequency from 2299774528 Hz to 2299775137 Hz I0229 08:47:37.787615 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:37.787716 2294 parameters.go:238] Clock(Realtime): error: 122 ns, adjusted frequency from 2299775106 Hz to 2299774907 Hz D0229 08:47:37.787827 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:37.787866 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872531755751181 monotonicBaseRef:16000292013 monotonicFrequency:2299775137 realtimeReady:1 realtimeBaseCycles:8872531756440603 realtimeBaseRef:1582966057787708674 realtimeFrequency:2299774907} D0229 08:47:37.787977 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:37.788130 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:37.788118 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:37.788270 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:37.788453 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:37.788621 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:47:38.140193 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:38.140370 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:38.140564 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:38.140682 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:38.140876 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:38.141096 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:38.787487 2294 parameters.go:238] Clock(Monotonic): error: -100 ns, adjusted frequency from 2299775137 Hz to 2299774455 Hz D0229 08:47:38.787773 2294 parameters.go:238] Clock(Realtime): error: -40 ns, adjusted frequency from 2299774907 Hz to 2299774563 Hz D0229 08:47:38.787978 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872534055657321 monotonicBaseRef:17000348976 monotonicFrequency:2299774455 realtimeReady:1 realtimeBaseCycles:8872534056343833 realtimeBaseRef:1582966058787764472 realtimeFrequency:2299774563} D0229 08:47:39.787403 2294 parameters.go:238] Clock(Monotonic): error: 215 ns, adjusted frequency from 2299774455 Hz to 2299775050 Hz D0229 08:47:39.787656 2294 parameters.go:238] Clock(Realtime): error: 9 ns, adjusted frequency from 2299774563 Hz to 2299774608 Hz D0229 08:47:39.787797 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872536355243267 monotonicBaseRef:18000267007 monotonicFrequency:2299775050 realtimeReady:1 realtimeBaseCycles:8872536355853146 realtimeBaseRef:1582966059787649134 realtimeFrequency:2299774608} D0229 08:47:40.787500 2294 parameters.go:238] Clock(Monotonic): error: -60 ns, adjusted frequency from 2299775050 Hz to 2299774428 Hz D0229 08:47:40.787754 2294 parameters.go:238] Clock(Realtime): error: 9 ns, adjusted frequency from 2299774608 Hz to 2299774625 Hz D0229 08:47:40.787940 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872538655234946 monotonicBaseRef:19000361202 monotonicFrequency:2299774428 realtimeReady:1 realtimeBaseCycles:8872538655852519 realtimeBaseRef:1582966060787746867 realtimeFrequency:2299774625} D0229 08:47:41.787452 2294 parameters.go:238] Clock(Monotonic): error: 120 ns, adjusted frequency from 2299774428 Hz to 2299774877 Hz D0229 08:47:41.787719 2294 parameters.go:238] Clock(Realtime): error: 167 ns, adjusted frequency from 2299774625 Hz to 2299774996 Hz D0229 08:47:41.787842 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872540954905752 monotonicBaseRef:20000316144 monotonicFrequency:2299774877 realtimeReady:1 realtimeBaseCycles:8872540955547364 realtimeBaseRef:1582966061787712176 realtimeFrequency:2299774996} I0229 08:47:42.140164 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:42.140428 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:42.140595 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:42.140663 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:42.140907 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:42.141030 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:42.787444 2294 parameters.go:238] Clock(Monotonic): error: -410 ns, adjusted frequency from 2299774877 Hz to 2299773714 Hz I0229 08:47:42.787625 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:42.787635 2294 parameters.go:238] Clock(Realtime): error: -254 ns, adjusted frequency from 2299774996 Hz to 2299774055 Hz D0229 08:47:42.787844 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:42.787983 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:42.787939 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872543254670623 monotonicBaseRef:21000311793 monotonicFrequency:2299773714 realtimeReady:1 realtimeBaseCycles:8872543255128837 realtimeBaseRef:1582966062787628027 realtimeFrequency:2299774055} D0229 08:47:42.788086 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:42.788110 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:42.788221 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:42.788372 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:42.788548 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:47:43.166847 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:43.167086 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:43.167216 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:43.167260 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:43.167446 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:43.167554 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:43.787376 2294 parameters.go:238] Clock(Monotonic): error: 212 ns, adjusted frequency from 2299773714 Hz to 2299775160 Hz D0229 08:47:43.787566 2294 parameters.go:238] Clock(Realtime): error: -14 ns, adjusted frequency from 2299774055 Hz to 2299774584 Hz D0229 08:47:43.787668 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872545554288486 monotonicBaseRef:22000244025 monotonicFrequency:2299775160 realtimeReady:1 realtimeBaseCycles:8872545554750802 realtimeBaseRef:1582966063787561894 realtimeFrequency:2299774584} D0229 08:47:44.787418 2294 parameters.go:238] Clock(Monotonic): error: 160 ns, adjusted frequency from 2299775160 Hz to 2299775006 Hz D0229 08:47:44.787659 2294 parameters.go:238] Clock(Realtime): error: 234 ns, adjusted frequency from 2299774584 Hz to 2299775135 Hz D0229 08:47:44.787830 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872547854148648 monotonicBaseRef:23000280986 monotonicFrequency:2299775006 realtimeReady:1 realtimeBaseCycles:8872547854735040 realtimeBaseRef:1582966064787653056 realtimeFrequency:2299775135} I0229 08:47:45.140164 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:45.140381 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:45.140508 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:45.140575 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:45.140831 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:45.140929 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:45.787435 2294 parameters.go:238] Clock(Monotonic): error: -466 ns, adjusted frequency from 2299775006 Hz to 2299773546 Hz I0229 08:47:45.787609 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:45.787822 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:45.787785 2294 parameters.go:238] Clock(Realtime): error: -112 ns, adjusted frequency from 2299775135 Hz to 2299774400 Hz D0229 08:47:45.787955 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:45.787977 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:45.788105 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:45.788012 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872550153958817 monotonicBaseRef:24000296275 monotonicFrequency:2299773546 realtimeReady:1 realtimeBaseCycles:8872550154793155 realtimeBaseRef:1582966065787776102 realtimeFrequency:2299774400} D0229 08:47:45.788182 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:45.788274 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:45.788205 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:45.788378 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:45.788639 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:45.788673 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:45.788739 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:45.788940 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:45.789048 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:47:46.787409 2294 parameters.go:238] Clock(Monotonic): error: 105 ns, adjusted frequency from 2299773546 Hz to 2299774835 Hz D0229 08:47:46.787647 2294 parameters.go:238] Clock(Realtime): error: -153 ns, adjusted frequency from 2299774400 Hz to 2299774290 Hz I0229 08:47:46.787619 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:46.787759 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872552453687971 monotonicBaseRef:25000276972 monotonicFrequency:2299774835 realtimeReady:1 realtimeBaseCycles:8872552454258651 realtimeBaseRef:1582966066787641782 realtimeFrequency:2299774290} D0229 08:47:46.787859 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:46.788041 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:46.788151 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:46.788207 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:46.788338 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:46.788448 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:46.788348 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:46.788578 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:46.789744 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:46.789926 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:46.789955 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:46.789536 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:46.790205 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:46.791349 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:47:46.791357 2294 task_signals.go:452] [ 2] Notified of group signal 23 D0229 08:47:46.791489 2294 task_block.go:223] [ 2] Interrupt queued I0229 08:47:46.791635 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:46.791732 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:46.791971 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:46.791944 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:46.792062 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:46.792265 2294 task_block.go:223] [ 3] Interrupt queued D0229 08:47:46.792243 2294 task_block.go:223] [ 3] Interrupt queued D0229 08:47:46.792465 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:46.792718 2294 task_signals.go:179] [ 3] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:46.792871 2294 task_signals.go:220] [ 3] Signal 23: delivering to handler D0229 08:47:47.787423 2294 parameters.go:238] Clock(Monotonic): error: 335 ns, adjusted frequency from 2299774835 Hz to 2299775297 Hz D0229 08:47:47.787711 2294 parameters.go:238] Clock(Realtime): error: 226 ns, adjusted frequency from 2299774290 Hz to 2299775096 Hz D0229 08:47:47.787905 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872554753476127 monotonicBaseRef:26000282764 monotonicFrequency:2299775297 realtimeReady:1 realtimeBaseCycles:8872554754176153 realtimeBaseRef:1582966067787704054 realtimeFrequency:2299775096} D0229 08:47:48.787441 2294 parameters.go:238] Clock(Monotonic): error: 64 ns, adjusted frequency from 2299775297 Hz to 2299774774 Hz D0229 08:47:48.787672 2294 parameters.go:238] Clock(Realtime): error: 83 ns, adjusted frequency from 2299775096 Hz to 2299774817 Hz D0229 08:47:48.787811 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872557053299385 monotonicBaseRef:27000303618 monotonicFrequency:2299774774 realtimeReady:1 realtimeBaseCycles:8872557053861910 realtimeBaseRef:1582966068787665207 realtimeFrequency:2299774817} I0229 08:47:49.140088 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:49.140323 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:49.140428 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:49.140462 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:49.140566 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:49.140700 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:49.140694 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:49.140782 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:49.140810 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:49.141155 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:49.141186 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:49.141228 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:49.141487 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:49.141585 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:47:49.787423 2294 parameters.go:238] Clock(Monotonic): error: -540 ns, adjusted frequency from 2299774774 Hz to 2299773420 Hz I0229 08:47:49.787524 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:49.787608 2294 parameters.go:238] Clock(Realtime): error: -517 ns, adjusted frequency from 2299774817 Hz to 2299773458 Hz D0229 08:47:49.787749 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:49.787746 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872559353039338 monotonicBaseRef:28000288476 monotonicFrequency:2299773420 realtimeReady:1 realtimeBaseCycles:8872559353492046 realtimeBaseRef:1582966069787602296 realtimeFrequency:2299773458} D0229 08:47:49.787843 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:49.787957 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:49.788020 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:49.788137 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:49.788318 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:49.788472 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:47:50.140018 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:50.140274 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:50.140400 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:50.140440 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:50.140578 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:50.140673 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:50.140713 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:50.140855 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:50.140981 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:50.141568 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:50.141604 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:50.141739 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:50.142010 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:50.142143 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:47:50.787420 2294 parameters.go:238] Clock(Monotonic): error: -126 ns, adjusted frequency from 2299773420 Hz to 2299774389 Hz D0229 08:47:50.787649 2294 parameters.go:238] Clock(Realtime): error: 223 ns, adjusted frequency from 2299773458 Hz to 2299775098 Hz D0229 08:47:50.787761 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872561652804324 monotonicBaseRef:29000284808 monotonicFrequency:2299774389 realtimeReady:1 realtimeBaseCycles:8872561653362258 realtimeBaseRef:1582966070787644367 realtimeFrequency:2299775098} D0229 08:47:51.788046 2294 parameters.go:238] Clock(Monotonic): error: 5 ns, adjusted frequency from 2299774389 Hz to 2299774706 Hz D0229 08:47:51.788259 2294 parameters.go:238] Clock(Realtime): error: 64 ns, adjusted frequency from 2299775098 Hz to 2299774734 Hz D0229 08:47:51.788386 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872563952663244 monotonicBaseRef:30000321564 monotonicFrequency:2299774706 realtimeReady:1 realtimeBaseCycles:8872563954536452 realtimeBaseRef:1582966071788252729 realtimeFrequency:2299774734} I0229 08:47:51.841604 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:51.841838 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:51.841935 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:51.842056 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:51.842078 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:51.842239 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:51.842413 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:51.842522 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:52.787545 2294 parameters.go:238] Clock(Monotonic): error: 283 ns, adjusted frequency from 2299774706 Hz to 2299775328 Hz I0229 08:47:52.787719 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:52.787915 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:52.787840 2294 parameters.go:238] Clock(Realtime): error: 220 ns, adjusted frequency from 2299774734 Hz to 2299775092 Hz D0229 08:47:52.788011 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:52.788139 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:52.788135 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:52.788050 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872566252635953 monotonicBaseRef:31000407660 monotonicFrequency:2299775328 realtimeReady:1 realtimeBaseCycles:8872566253343407 realtimeBaseRef:1582966072787831914 realtimeFrequency:2299775092} D0229 08:47:52.788457 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:52.788599 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:52.788564 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:52.788738 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:52.788985 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:52.789104 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:52.789131 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:52.789350 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:52.789471 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:47:53.166753 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:53.167016 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:53.167166 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:53.167337 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:53.167507 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:53.167636 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:47:53.177534 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:53.177708 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:53.177803 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:53.177907 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:53.178005 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:53.177980 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:53.178276 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:53.178399 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:53.787310 2294 parameters.go:238] Clock(Monotonic): error: 24 ns, adjusted frequency from 2299775328 Hz to 2299774693 Hz D0229 08:47:53.787480 2294 parameters.go:238] Clock(Realtime): error: -244 ns, adjusted frequency from 2299775092 Hz to 2299774064 Hz I0229 08:47:53.787572 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:53.787795 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:53.787928 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:53.787791 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872568551889841 monotonicBaseRef:32000180924 monotonicFrequency:2299774693 realtimeReady:1 realtimeBaseCycles:8872568552300333 realtimeBaseRef:1582966073787476154 realtimeFrequency:2299774064} D0229 08:47:53.788002 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:53.788055 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:53.788171 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:53.788373 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:53.788478 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:47:53.850986 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:53.851190 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:53.851287 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:53.851333 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:53.851453 2294 urpc.go:577] urpc: unmarshal success. D0229 08:47:53.851593 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:53.851734 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:53.851746 2294 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0229 08:47:53.852077 2294 urpc.go:534] urpc: successfully marshalled 37 bytes. I0229 08:47:54.140212 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:54.140413 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:54.140512 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:54.140607 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:54.140778 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:54.140970 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:54.787422 2294 parameters.go:238] Clock(Monotonic): error: -15 ns, adjusted frequency from 2299774693 Hz to 2299774513 Hz D0229 08:47:54.787602 2294 parameters.go:238] Clock(Realtime): error: 154 ns, adjusted frequency from 2299774064 Hz to 2299774937 Hz D0229 08:47:54.787733 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872570851920741 monotonicBaseRef:33000292329 monotonicFrequency:2299774513 realtimeReady:1 realtimeBaseCycles:8872570852351459 realtimeBaseRef:1582966074787596627 realtimeFrequency:2299774937} I0229 08:47:55.140225 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:55.140450 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:55.140613 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:55.140729 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:55.140912 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:55.141017 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:55.787439 2294 parameters.go:238] Clock(Monotonic): error: 186 ns, adjusted frequency from 2299774513 Hz to 2299775027 Hz D0229 08:47:55.787631 2294 parameters.go:238] Clock(Realtime): error: -248 ns, adjusted frequency from 2299774937 Hz to 2299774066 Hz I0229 08:47:55.787540 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:55.787818 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:55.787750 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872573151662033 monotonicBaseRef:34000277883 monotonicFrequency:2299775027 realtimeReady:1 realtimeBaseCycles:8872573152190788 realtimeBaseRef:1582966075787624626 realtimeFrequency:2299774066} D0229 08:47:55.787955 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:55.788105 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:55.788161 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:55.788298 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:47:55.788477 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:55.788612 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:56.787392 2294 parameters.go:238] Clock(Monotonic): error: -13 ns, adjusted frequency from 2299775027 Hz to 2299774619 Hz D0229 08:47:56.787643 2294 parameters.go:238] Clock(Realtime): error: 644 ns, adjusted frequency from 2299774066 Hz to 2299776114 Hz D0229 08:47:56.787795 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872575451381853 monotonicBaseRef:35000253877 monotonicFrequency:2299774619 realtimeReady:1 realtimeBaseCycles:8872575451976508 realtimeBaseRef:1582966076787629693 realtimeFrequency:2299776114} I0229 08:47:57.140337 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:57.140588 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:57.140788 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:57.140879 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:57.140978 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:57.141051 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:57.141171 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:57.141127 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:57.141272 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:57.141559 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:57.141612 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:57.141640 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:57.141923 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:57.142070 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:47:57.787452 2294 parameters.go:238] Clock(Monotonic): error: -279 ns, adjusted frequency from 2299774619 Hz to 2299774036 Hz D0229 08:47:57.787656 2294 parameters.go:238] Clock(Realtime): error: -270 ns, adjusted frequency from 2299776114 Hz to 2299773954 Hz I0229 08:47:57.787867 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:57.787853 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872577751221336 monotonicBaseRef:36000282081 monotonicFrequency:2299774036 realtimeReady:1 realtimeBaseCycles:8872577751781386 realtimeBaseRef:1582966077787642200 realtimeFrequency:2299773954} D0229 08:47:57.788127 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:57.788295 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:57.788349 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:47:57.788477 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:47:57.788592 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:47:57.788714 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:47:57.788603 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:47:57.788978 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:57.789150 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:57.789150 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:47:57.789365 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:47:57.789532 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:47:57.789674 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:47:58.787264 2294 parameters.go:238] Clock(Monotonic): error: 850 ns, adjusted frequency from 2299774036 Hz to 2299776651 Hz D0229 08:47:58.787463 2294 parameters.go:238] Clock(Realtime): error: -232 ns, adjusted frequency from 2299773954 Hz to 2299774049 Hz D0229 08:47:58.787577 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872580050649021 monotonicBaseRef:37000131478 monotonicFrequency:2299776651 realtimeReady:1 realtimeBaseCycles:8872580051130145 realtimeBaseRef:1582966078787457314 realtimeFrequency:2299774049} D0229 08:47:59.787674 2294 parameters.go:238] Clock(Monotonic): error: -733 ns, adjusted frequency from 2299776651 Hz to 2299772906 Hz D0229 08:47:59.787825 2294 parameters.go:238] Clock(Realtime): error: 206 ns, adjusted frequency from 2299774049 Hz to 2299775113 Hz D0229 08:47:59.787983 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872582351371992 monotonicBaseRef:38000542961 monotonicFrequency:2299772906 realtimeReady:1 realtimeBaseCycles:8872582351736743 realtimeBaseRef:1582966079787819327 realtimeFrequency:2299775113} D0229 08:48:00.787451 2294 parameters.go:238] Clock(Monotonic): error: 241 ns, adjusted frequency from 2299772906 Hz to 2299775113 Hz D0229 08:48:00.787714 2294 parameters.go:238] Clock(Realtime): error: -195 ns, adjusted frequency from 2299775113 Hz to 2299774203 Hz D0229 08:48:00.787915 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872584650626695 monotonicBaseRef:39000317633 monotonicFrequency:2299775113 realtimeReady:1 realtimeBaseCycles:8872584651245371 realtimeBaseRef:1582966080787703452 realtimeFrequency:2299774203} D0229 08:48:01.787336 2294 parameters.go:238] Clock(Monotonic): error: -172 ns, adjusted frequency from 2299775113 Hz to 2299774187 Hz D0229 08:48:01.787513 2294 parameters.go:238] Clock(Realtime): error: -65 ns, adjusted frequency from 2299774203 Hz to 2299774512 Hz I0229 08:48:01.787564 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:01.787680 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872586950145145 monotonicBaseRef:40000206029 monotonicFrequency:2299774187 realtimeReady:1 realtimeBaseCycles:8872586950570790 realtimeBaseRef:1582966081787508309 realtimeFrequency:2299774512} D0229 08:48:01.787916 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:01.788082 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:01.788143 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:01.788227 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:01.788352 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:01.788533 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:01.788680 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:02.140258 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:02.140494 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:02.140582 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:02.140689 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:02.140812 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:02.140952 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:02.787375 2294 parameters.go:238] Clock(Monotonic): error: -228 ns, adjusted frequency from 2299774187 Hz to 2299774097 Hz D0229 08:48:02.787558 2294 parameters.go:238] Clock(Realtime): error: 146 ns, adjusted frequency from 2299774512 Hz to 2299774934 Hz D0229 08:48:02.787651 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872589250003033 monotonicBaseRef:41000242424 monotonicFrequency:2299774097 realtimeReady:1 realtimeBaseCycles:8872589250444463 realtimeBaseRef:1582966082787551426 realtimeFrequency:2299774934} I0229 08:48:03.140089 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:03.140287 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:03.140423 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:03.140557 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:03.140658 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:03.140646 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:03.140856 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:03.141004 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:03.788132 2294 parameters.go:238] Clock(Monotonic): error: 265 ns, adjusted frequency from 2299774097 Hz to 2299775266 Hz I0229 08:48:03.788242 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:03.788380 2294 parameters.go:238] Clock(Realtime): error: 86 ns, adjusted frequency from 2299774934 Hz to 2299774798 Hz D0229 08:48:03.788528 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:03.788522 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872591551447634 monotonicBaseRef:42000968801 monotonicFrequency:2299775266 realtimeReady:1 realtimeBaseCycles:8872591552107308 realtimeBaseRef:1582966083788372337 realtimeFrequency:2299774798} D0229 08:48:03.788617 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:03.788695 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:03.788860 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:03.788953 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:04.787235 2294 parameters.go:238] Clock(Monotonic): error: 33 ns, adjusted frequency from 2299775266 Hz to 2299774745 Hz D0229 08:48:04.787460 2294 parameters.go:238] Clock(Realtime): error: -191 ns, adjusted frequency from 2299774798 Hz to 2299774151 Hz I0229 08:48:04.787422 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:04.787589 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872593849217386 monotonicBaseRef:43000096753 monotonicFrequency:2299774745 realtimeReady:1 realtimeBaseCycles:8872593849770376 realtimeBaseRef:1582966084787454103 realtimeFrequency:2299774151} D0229 08:48:04.787744 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:04.787892 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:04.787939 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:04.788147 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:04.788312 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:05.140243 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:05.140458 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:05.140541 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:05.140703 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:05.140891 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:05.141041 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:05.787920 2294 parameters.go:238] Clock(Monotonic): error: -96 ns, adjusted frequency from 2299774745 Hz to 2299774361 Hz D0229 08:48:05.788147 2294 parameters.go:238] Clock(Realtime): error: 92 ns, adjusted frequency from 2299774151 Hz to 2299774754 Hz I0229 08:48:05.789227 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:05.788946 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872596150576242 monotonicBaseRef:44000785564 monotonicFrequency:2299774361 realtimeReady:1 realtimeBaseCycles:8872596151122637 realtimeBaseRef:1582966085788140305 realtimeFrequency:2299774754} D0229 08:48:05.789475 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:05.789613 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:05.789743 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:05.789829 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:05.790104 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:05.790096 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:05.790342 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:05.790206 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:05.791673 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:05.791779 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:05.791967 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:05.792066 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:05.792102 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:05.792275 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:05.792408 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:06.787405 2294 parameters.go:238] Clock(Monotonic): error: -18 ns, adjusted frequency from 2299774361 Hz to 2299774526 Hz D0229 08:48:06.787596 2294 parameters.go:238] Clock(Realtime): error: -4 ns, adjusted frequency from 2299774754 Hz to 2299774653 Hz D0229 08:48:06.787691 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872598449175746 monotonicBaseRef:45000274706 monotonicFrequency:2299774526 realtimeReady:1 realtimeBaseCycles:8872598449633470 realtimeBaseRef:1582966086787590720 realtimeFrequency:2299774653} I0229 08:48:07.105872 2294 watchdog.go:277] Watchdog starting loop, tasks: 15, discount: 0s D0229 08:48:07.787452 2294 parameters.go:238] Clock(Monotonic): error: 311 ns, adjusted frequency from 2299774526 Hz to 2299775225 Hz I0229 08:48:07.787619 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:07.787736 2294 parameters.go:238] Clock(Realtime): error: 182 ns, adjusted frequency from 2299774653 Hz to 2299775037 Hz D0229 08:48:07.787826 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:07.787976 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:07.788016 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:07.787952 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872600749013796 monotonicBaseRef:46000302327 monotonicFrequency:2299775225 realtimeReady:1 realtimeBaseCycles:8872600749723109 realtimeBaseRef:1582966087787727683 realtimeFrequency:2299775037} I0229 08:48:07.788139 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:07.788289 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:07.788414 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:07.788467 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:07.788506 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:07.788941 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:07.789039 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:07.789066 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:07.789256 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:07.789409 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:48:08.140100 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:08.140331 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:08.140583 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:08.140707 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:08.140969 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:08.141117 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:08.787409 2294 parameters.go:238] Clock(Monotonic): error: 82 ns, adjusted frequency from 2299775225 Hz to 2299774813 Hz D0229 08:48:08.787599 2294 parameters.go:238] Clock(Realtime): error: -336 ns, adjusted frequency from 2299775037 Hz to 2299773833 Hz I0229 08:48:08.787567 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:08.787693 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872603048727854 monotonicBaseRef:47000275730 monotonicFrequency:2299774813 realtimeReady:1 realtimeBaseCycles:8872603049191449 realtimeBaseRef:1582966088787594323 realtimeFrequency:2299773833} D0229 08:48:08.787761 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:08.787967 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:08.787995 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:08.788242 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:08.788397 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:09.140054 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:09.140346 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:09.140532 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:09.140589 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:09.140860 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:09.140949 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:09.788039 2294 parameters.go:238] Clock(Monotonic): error: -377 ns, adjusted frequency from 2299774813 Hz to 2299773743 Hz D0229 08:48:09.788222 2294 parameters.go:238] Clock(Realtime): error: 47 ns, adjusted frequency from 2299773833 Hz to 2299774679 Hz D0229 08:48:09.788320 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872605349962071 monotonicBaseRef:48000910315 monotonicFrequency:2299773743 realtimeReady:1 realtimeBaseCycles:8872605350397400 realtimeBaseRef:1582966089788217044 realtimeFrequency:2299774679} D0229 08:48:10.787406 2294 parameters.go:238] Clock(Monotonic): error: -374 ns, adjusted frequency from 2299773743 Hz to 2299773780 Hz D0229 08:48:10.787594 2294 parameters.go:238] Clock(Realtime): error: 44 ns, adjusted frequency from 2299774679 Hz to 2299774686 Hz D0229 08:48:10.787691 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872607648271661 monotonicBaseRef:49000273664 monotonicFrequency:2299773780 realtimeReady:1 realtimeBaseCycles:8872607648726658 realtimeBaseRef:1582966090787588538 realtimeFrequency:2299774686} D0229 08:48:11.787343 2294 parameters.go:238] Clock(Monotonic): error: 229 ns, adjusted frequency from 2299773780 Hz to 2299775128 Hz D0229 08:48:11.787539 2294 parameters.go:238] Clock(Realtime): error: 128 ns, adjusted frequency from 2299774686 Hz to 2299774911 Hz D0229 08:48:11.787697 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872609947901085 monotonicBaseRef:50000210894 monotonicFrequency:2299775128 realtimeReady:1 realtimeBaseCycles:8872609948374286 realtimeBaseRef:1582966091787533289 realtimeFrequency:2299774911} D0229 08:48:12.787424 2294 parameters.go:238] Clock(Monotonic): error: 255 ns, adjusted frequency from 2299775128 Hz to 2299775184 Hz D0229 08:48:12.787638 2294 parameters.go:238] Clock(Realtime): error: -18 ns, adjusted frequency from 2299774911 Hz to 2299774570 Hz D0229 08:48:12.787755 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872612247852267 monotonicBaseRef:51000287446 monotonicFrequency:2299775184 realtimeReady:1 realtimeBaseCycles:8872612248375616 realtimeBaseRef:1582966092787631741 realtimeFrequency:2299774570} D0229 08:48:13.787354 2294 parameters.go:238] Clock(Monotonic): error: 46 ns, adjusted frequency from 2299775184 Hz to 2299774741 Hz D0229 08:48:13.787554 2294 parameters.go:238] Clock(Realtime): error: 190 ns, adjusted frequency from 2299774570 Hz to 2299775050 Hz D0229 08:48:13.787697 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872614547464332 monotonicBaseRef:52000216517 monotonicFrequency:2299774741 realtimeReady:1 realtimeBaseCycles:8872614547956985 realtimeBaseRef:1582966093787547732 realtimeFrequency:2299775050} I0229 08:48:14.141066 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:14.141247 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:14.141353 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:14.141479 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:14.141669 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:14.141784 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:14.787560 2294 parameters.go:238] Clock(Monotonic): error: -15 ns, adjusted frequency from 2299774741 Hz to 2299774607 Hz D0229 08:48:14.787769 2294 parameters.go:238] Clock(Realtime): error: -123 ns, adjusted frequency from 2299775050 Hz to 2299774384 Hz D0229 08:48:14.787859 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872616847725444 monotonicBaseRef:53000428003 monotonicFrequency:2299774607 realtimeReady:1 realtimeBaseCycles:8872616848225946 realtimeBaseRef:1582966094787762496 realtimeFrequency:2299774384} D0229 08:48:15.787806 2294 parameters.go:238] Clock(Monotonic): error: -431 ns, adjusted frequency from 2299774607 Hz to 2299773672 Hz D0229 08:48:15.788010 2294 parameters.go:238] Clock(Realtime): error: -10 ns, adjusted frequency from 2299774384 Hz to 2299774541 Hz D0229 08:48:15.788133 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872619148067752 monotonicBaseRef:54000674853 monotonicFrequency:2299773672 realtimeReady:1 realtimeBaseCycles:8872619148556760 realtimeBaseRef:1582966095788004445 realtimeFrequency:2299774541} D0229 08:48:16.787763 2294 parameters.go:238] Clock(Monotonic): error: 330 ns, adjusted frequency from 2299773672 Hz to 2299775343 Hz D0229 08:48:16.788006 2294 parameters.go:238] Clock(Realtime): error: -319 ns, adjusted frequency from 2299774541 Hz to 2299773910 Hz I0229 08:48:16.788154 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:16.788163 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872621447730179 monotonicBaseRef:55000626480 monotonicFrequency:2299775343 realtimeReady:1 realtimeBaseCycles:8872621448321534 realtimeBaseRef:1582966096788000198 realtimeFrequency:2299773910} D0229 08:48:16.788389 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:16.788530 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:16.788637 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:16.788883 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:16.789030 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:17.140920 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:17.141165 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:17.141307 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:17.141348 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:17.141582 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:17.141686 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:17.787449 2294 parameters.go:238] Clock(Monotonic): error: 546 ns, adjusted frequency from 2299775343 Hz to 2299775898 Hz D0229 08:48:17.787639 2294 parameters.go:238] Clock(Realtime): error: 184 ns, adjusted frequency from 2299773910 Hz to 2299775049 Hz D0229 08:48:17.787770 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872623746735639 monotonicBaseRef:56000291715 monotonicFrequency:2299775898 realtimeReady:1 realtimeBaseCycles:8872623747241583 realtimeBaseRef:1582966097787628917 realtimeFrequency:2299775049} D0229 08:48:18.788422 2294 parameters.go:238] Clock(Monotonic): error: -455 ns, adjusted frequency from 2299775898 Hz to 2299773582 Hz D0229 08:48:18.788671 2294 parameters.go:238] Clock(Realtime): error: 229 ns, adjusted frequency from 2299775049 Hz to 2299775166 Hz I0229 08:48:18.788625 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:18.788878 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:18.788772 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872626048800129 monotonicBaseRef:57001286851 monotonicFrequency:2299773582 realtimeReady:1 realtimeBaseCycles:8872626049397900 realtimeBaseRef:1582966098788664352 realtimeFrequency:2299775166} D0229 08:48:18.788991 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:18.789116 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:18.789101 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:18.789204 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:18.789350 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:18.789483 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:19.140049 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:19.140295 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:19.140418 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:19.140544 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:19.140595 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:19.140754 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:19.140863 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:19.140849 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:19.141130 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:19.141306 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:19.141331 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:19.141413 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:19.141617 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:19.141756 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:19.788292 2294 parameters.go:238] Clock(Monotonic): error: -287 ns, adjusted frequency from 2299773582 Hz to 2299773976 Hz D0229 08:48:19.788529 2294 parameters.go:238] Clock(Realtime): error: -83 ns, adjusted frequency from 2299775166 Hz to 2299774448 Hz D0229 08:48:19.788763 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872628348268782 monotonicBaseRef:58001154260 monotonicFrequency:2299773976 realtimeReady:1 realtimeBaseCycles:8872628348848031 realtimeBaseRef:1582966099788523018 realtimeFrequency:2299774448} D0229 08:48:20.787375 2294 parameters.go:238] Clock(Monotonic): error: -281 ns, adjusted frequency from 2299773976 Hz to 2299774018 Hz I0229 08:48:20.787523 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:20.787590 2294 parameters.go:238] Clock(Realtime): error: -194 ns, adjusted frequency from 2299774448 Hz to 2299774156 Hz D0229 08:48:20.787810 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872630645882515 monotonicBaseRef:59000214931 monotonicFrequency:2299774018 realtimeReady:1 realtimeBaseCycles:8872630646462801 realtimeBaseRef:1582966100787583935 realtimeFrequency:2299774156} D0229 08:48:20.787818 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:20.788055 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:20.788123 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:20.788220 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:20.788341 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:20.788502 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:20.788639 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:21.140196 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:21.140418 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:21.140602 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:21.140733 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:21.140785 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:21.141002 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:21.140988 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:21.141188 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:21.141112 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:21.141755 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:21.141712 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:21.141981 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:21.142127 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:21.142330 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:21.787404 2294 parameters.go:238] Clock(Monotonic): error: 44 ns, adjusted frequency from 2299774018 Hz to 2299774761 Hz D0229 08:48:21.787811 2294 parameters.go:238] Clock(Realtime): error: 84 ns, adjusted frequency from 2299774156 Hz to 2299774813 Hz D0229 08:48:21.787944 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872632945783885 monotonicBaseRef:60000270306 monotonicFrequency:2299774761 realtimeReady:1 realtimeBaseCycles:8872632946744379 realtimeBaseRef:1582966101787804574 realtimeFrequency:2299774813} D0229 08:48:22.787255 2294 parameters.go:238] Clock(Monotonic): error: 257 ns, adjusted frequency from 2299774761 Hz to 2299775117 Hz D0229 08:48:22.787490 2294 parameters.go:238] Clock(Realtime): error: -146 ns, adjusted frequency from 2299774813 Hz to 2299774266 Hz I0229 08:48:22.787772 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:22.788108 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:22.787842 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872635245217843 monotonicBaseRef:61000122116 monotonicFrequency:2299775117 realtimeReady:1 realtimeBaseCycles:8872635245785161 realtimeBaseRef:1582966102787485398 realtimeFrequency:2299774266} D0229 08:48:22.788248 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:22.788299 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:22.788394 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:22.788490 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:22.788977 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:22.789099 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:23.787425 2294 parameters.go:238] Clock(Monotonic): error: -21 ns, adjusted frequency from 2299775117 Hz to 2299774620 Hz D0229 08:48:23.787641 2294 parameters.go:238] Clock(Realtime): error: 64 ns, adjusted frequency from 2299774266 Hz to 2299774766 Hz I0229 08:48:23.787629 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:23.787740 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872637545376824 monotonicBaseRef:62000289029 monotonicFrequency:2299774620 realtimeReady:1 realtimeBaseCycles:8872637545906449 realtimeBaseRef:1582966103787636291 realtimeFrequency:2299774766} D0229 08:48:23.787981 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:23.788124 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:23.788144 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:23.788271 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:23.788365 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:23.788415 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:23.788479 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:23.788512 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:23.789003 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:23.789093 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:23.789122 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:23.789260 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:23.789391 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:48:24.140011 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:24.140234 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:24.140351 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:24.140496 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:24.140636 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:24.140846 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:24.787297 2294 parameters.go:238] Clock(Monotonic): error: -275 ns, adjusted frequency from 2299774620 Hz to 2299773972 Hz D0229 08:48:24.787516 2294 parameters.go:238] Clock(Realtime): error: 80 ns, adjusted frequency from 2299774766 Hz to 2299774839 Hz D0229 08:48:24.787663 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872639844857154 monotonicBaseRef:63000161064 monotonicFrequency:2299773972 realtimeReady:1 realtimeBaseCycles:8872639845391750 realtimeBaseRef:1582966104787510424 realtimeFrequency:2299774839} I0229 08:48:25.002030 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:25.002175 2294 urpc.go:577] urpc: unmarshal success. D0229 08:48:25.002290 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:25.002407 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:25.002421 2294 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0229 08:48:25.002531 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:25.002579 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:25.002722 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:25.002770 2294 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 08:48:25.002871 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:25.002991 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:25.787378 2294 parameters.go:238] Clock(Monotonic): error: 539 ns, adjusted frequency from 2299773972 Hz to 2299775999 Hz I0229 08:48:25.787549 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:25.787601 2294 parameters.go:238] Clock(Realtime): error: 157 ns, adjusted frequency from 2299774839 Hz to 2299774968 Hz D0229 08:48:25.787862 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:25.787854 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872642144813368 monotonicBaseRef:64000240307 monotonicFrequency:2299775999 realtimeReady:1 realtimeBaseCycles:8872642145353222 realtimeBaseRef:1582966105787591576 realtimeFrequency:2299774968} D0229 08:48:25.788069 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:25.788137 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:25.788277 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:25.788452 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:25.788472 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:25.788589 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:25.788632 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:25.789040 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:25.789183 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:25.789568 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:25.789730 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:25.789855 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:26.787423 2294 parameters.go:238] Clock(Monotonic): error: 144 ns, adjusted frequency from 2299775999 Hz to 2299774891 Hz D0229 08:48:26.787633 2294 parameters.go:238] Clock(Realtime): error: 208 ns, adjusted frequency from 2299774968 Hz to 2299775116 Hz D0229 08:48:26.787754 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872644444693676 monotonicBaseRef:65000285663 monotonicFrequency:2299774891 realtimeReady:1 realtimeBaseCycles:8872644445206793 realtimeBaseRef:1582966106787625754 realtimeFrequency:2299775116} D0229 08:48:27.787716 2294 parameters.go:238] Clock(Monotonic): error: -737 ns, adjusted frequency from 2299774891 Hz to 2299772958 Hz D0229 08:48:27.787958 2294 parameters.go:238] Clock(Realtime): error: -502 ns, adjusted frequency from 2299775116 Hz to 2299773443 Hz D0229 08:48:27.788082 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872646744460776 monotonicBaseRef:66000282275 monotonicFrequency:2299772958 realtimeReady:1 realtimeBaseCycles:8872646745729587 realtimeBaseRef:1582966107787950863 realtimeFrequency:2299773443} D0229 08:48:28.787406 2294 parameters.go:238] Clock(Monotonic): error: 316 ns, adjusted frequency from 2299772958 Hz to 2299775204 Hz I0229 08:48:28.787532 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:28.787632 2294 parameters.go:238] Clock(Realtime): error: 79 ns, adjusted frequency from 2299773443 Hz to 2299774787 Hz D0229 08:48:28.787907 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:28.787939 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872649044213019 monotonicBaseRef:67000273267 monotonicFrequency:2299775204 realtimeReady:1 realtimeBaseCycles:8872649044757978 realtimeBaseRef:1582966108787626895 realtimeFrequency:2299774787} D0229 08:48:28.788090 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:28.788165 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:28.788456 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:28.788610 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:29.787511 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:29.787436 2294 parameters.go:238] Clock(Monotonic): error: 118 ns, adjusted frequency from 2299775204 Hz to 2299774921 Hz D0229 08:48:29.787744 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:29.787867 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:29.787842 2294 parameters.go:238] Clock(Realtime): error: 181 ns, adjusted frequency from 2299774787 Hz to 2299775060 Hz D0229 08:48:29.787932 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:29.788019 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:29.788030 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872651344037376 monotonicBaseRef:68000294639 monotonicFrequency:2299774921 realtimeReady:1 realtimeBaseCycles:8872651345005866 realtimeBaseRef:1582966109787832611 realtimeFrequency:2299775060} D0229 08:48:29.788133 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:29.788249 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:29.788406 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:30.140363 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:30.140632 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:30.140789 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:30.140821 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:30.141029 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:30.141080 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:30.141266 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:30.141474 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:30.141356 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:30.142050 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:30.142144 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:30.142104 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:30.142365 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:30.142561 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:30.787401 2294 parameters.go:238] Clock(Monotonic): error: 184 ns, adjusted frequency from 2299774921 Hz to 2299774939 Hz D0229 08:48:30.787656 2294 parameters.go:238] Clock(Realtime): error: -267 ns, adjusted frequency from 2299775060 Hz to 2299773994 Hz D0229 08:48:30.787750 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872653643748113 monotonicBaseRef:69000266730 monotonicFrequency:2299774939 realtimeReady:1 realtimeBaseCycles:8872653644361088 realtimeBaseRef:1582966110787650054 realtimeFrequency:2299773994} I0229 08:48:31.140136 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:31.140364 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:31.140473 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:31.140548 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:31.140657 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:31.140822 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:31.140985 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:31.141003 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:31.141178 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:31.141931 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:31.142058 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:31.142108 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:31.142234 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:31.142335 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:31.787374 2294 parameters.go:238] Clock(Monotonic): error: -192 ns, adjusted frequency from 2299774939 Hz to 2299774230 Hz D0229 08:48:31.787624 2294 parameters.go:238] Clock(Realtime): error: 44 ns, adjusted frequency from 2299773994 Hz to 2299774726 Hz D0229 08:48:31.787782 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872655943462453 monotonicBaseRef:70000240380 monotonicFrequency:2299774230 realtimeReady:1 realtimeBaseCycles:8872655944060817 realtimeBaseRef:1582966111787617761 realtimeFrequency:2299774726} I0229 08:48:31.787778 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:31.788029 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:31.788219 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:31.788296 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:31.788416 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:31.788544 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:31.788661 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:31.788589 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:31.788780 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:31.789044 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:31.789140 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:31.789153 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:31.789342 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:31.789488 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:48:32.140667 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:32.140869 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:32.140979 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:32.141009 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:32.141080 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:32.141213 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:32.141233 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:32.141324 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:32.141348 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:32.142388 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:32.142475 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:32.142450 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:32.142964 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:32.143787 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0229 08:48:32.143976 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:32.144120 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:32.144222 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:32.144292 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:32.144314 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:32.144500 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:32.144611 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:32.144754 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:32.787430 2294 parameters.go:238] Clock(Monotonic): error: 99 ns, adjusted frequency from 2299774230 Hz to 2299774733 Hz D0229 08:48:32.787755 2294 parameters.go:238] Clock(Realtime): error: 135 ns, adjusted frequency from 2299774726 Hz to 2299774896 Hz D0229 08:48:32.787868 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872658243344433 monotonicBaseRef:71000287232 monotonicFrequency:2299774733 realtimeReady:1 realtimeBaseCycles:8872658244136250 realtimeBaseRef:1582966112787748515 realtimeFrequency:2299774896} I0229 08:48:33.140078 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:33.140265 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:33.140491 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:33.140609 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:33.140916 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:33.141117 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:33.787387 2294 parameters.go:238] Clock(Monotonic): error: -248 ns, adjusted frequency from 2299774733 Hz to 2299774043 Hz D0229 08:48:33.787618 2294 parameters.go:238] Clock(Realtime): error: 177 ns, adjusted frequency from 2299774896 Hz to 2299775038 Hz D0229 08:48:33.787803 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872660543034727 monotonicBaseRef:72000250515 monotonicFrequency:2299774043 realtimeReady:1 realtimeBaseCycles:8872660543592376 realtimeBaseRef:1582966113787609905 realtimeFrequency:2299775038} D0229 08:48:34.787466 2294 parameters.go:238] Clock(Monotonic): error: 10 ns, adjusted frequency from 2299774043 Hz to 2299774578 Hz I0229 08:48:34.787704 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:34.787742 2294 parameters.go:238] Clock(Realtime): error: -221 ns, adjusted frequency from 2299775038 Hz to 2299774096 Hz D0229 08:48:34.787971 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:34.787945 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872662842990098 monotonicBaseRef:73000329361 monotonicFrequency:2299774578 realtimeReady:1 realtimeBaseCycles:8872662843655618 realtimeBaseRef:1582966114787735223 realtimeFrequency:2299774096} D0229 08:48:34.788132 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:34.788259 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:34.788606 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 08:48:34.788694 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:34.788692 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:34.788883 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:34.789058 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:34.789354 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:34.789401 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:34.789465 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:34.789634 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:34.789829 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:35.787518 2294 parameters.go:238] Clock(Monotonic): error: 176 ns, adjusted frequency from 2299774578 Hz to 2299774925 Hz D0229 08:48:35.787718 2294 parameters.go:238] Clock(Realtime): error: -89 ns, adjusted frequency from 2299774096 Hz to 2299774377 Hz D0229 08:48:35.787801 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872665142892201 monotonicBaseRef:74000384812 monotonicFrequency:2299774925 realtimeReady:1 realtimeBaseCycles:8872665143379873 realtimeBaseRef:1582966115787713550 realtimeFrequency:2299774377} I0229 08:48:36.140175 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:36.140438 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:36.140625 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:36.140757 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:36.140815 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:36.140958 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:36.140989 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:36.141088 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:36.141146 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:36.141755 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:36.141827 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:36.141874 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:36.142031 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:36.142151 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:36.787625 2294 parameters.go:238] Clock(Monotonic): error: -136 ns, adjusted frequency from 2299774925 Hz to 2299774320 Hz D0229 08:48:36.787853 2294 parameters.go:238] Clock(Realtime): error: 182 ns, adjusted frequency from 2299774377 Hz to 2299775025 Hz D0229 08:48:36.787999 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872667442908716 monotonicBaseRef:75000489861 monotonicFrequency:2299774320 realtimeReady:1 realtimeBaseCycles:8872667443462400 realtimeBaseRef:1582966116787847541 realtimeFrequency:2299775025} I0229 08:48:37.140116 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:37.140307 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:37.140420 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:37.140549 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:37.140536 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:37.140637 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:37.140727 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:37.140826 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:37.787401 2294 parameters.go:238] Clock(Monotonic): error: 253 ns, adjusted frequency from 2299774320 Hz to 2299775257 Hz D0229 08:48:37.787614 2294 parameters.go:238] Clock(Realtime): error: -85 ns, adjusted frequency from 2299775025 Hz to 2299774391 Hz D0229 08:48:37.787760 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872669742160939 monotonicBaseRef:76000262840 monotonicFrequency:2299775257 realtimeReady:1 realtimeBaseCycles:8872669742684993 realtimeBaseRef:1582966117787607329 realtimeFrequency:2299774391} I0229 08:48:38.140284 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:38.140527 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:38.140637 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:38.140704 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:38.140779 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:38.140891 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:38.140860 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:38.140990 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:38.141010 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:38.141464 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:38.141570 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:38.141656 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:38.141942 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:38.142087 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:38.787397 2294 parameters.go:238] Clock(Monotonic): error: 414 ns, adjusted frequency from 2299775257 Hz to 2299775582 Hz D0229 08:48:38.787609 2294 parameters.go:238] Clock(Realtime): error: -121 ns, adjusted frequency from 2299774391 Hz to 2299774308 Hz D0229 08:48:38.787724 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872672041931063 monotonicBaseRef:77000260608 monotonicFrequency:2299775582 realtimeReady:1 realtimeBaseCycles:8872672042451718 realtimeBaseRef:1582966118787603995 realtimeFrequency:2299774308} I0229 08:48:39.140236 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:39.140485 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:39.140603 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:39.140730 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:39.140728 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:39.140827 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:39.140991 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:39.141088 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:39.787487 2294 parameters.go:238] Clock(Monotonic): error: -528 ns, adjusted frequency from 2299775582 Hz to 2299773346 Hz I0229 08:48:39.787684 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:39.787695 2294 parameters.go:238] Clock(Realtime): error: 298 ns, adjusted frequency from 2299774308 Hz to 2299775304 Hz D0229 08:48:39.787925 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:39.787928 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872674341920102 monotonicBaseRef:78000353424 monotonicFrequency:2299773346 realtimeReady:1 realtimeBaseCycles:8872674342421110 realtimeBaseRef:1582966119787688822 realtimeFrequency:2299775304} D0229 08:48:39.788104 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:39.788228 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:39.788532 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:39.788707 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:40.787347 2294 parameters.go:238] Clock(Monotonic): error: 23 ns, adjusted frequency from 2299773346 Hz to 2299774700 Hz D0229 08:48:40.787578 2294 parameters.go:238] Clock(Realtime): error: -239 ns, adjusted frequency from 2299775304 Hz to 2299774047 Hz I0229 08:48:40.787558 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:40.787697 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872676641376677 monotonicBaseRef:79000215683 monotonicFrequency:2299774700 realtimeReady:1 realtimeBaseCycles:8872676641927199 realtimeBaseRef:1582966120787571760 realtimeFrequency:2299774047} D0229 08:48:40.787848 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:40.788036 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:40.788082 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:40.788270 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:40.788402 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:41.787425 2294 parameters.go:238] Clock(Monotonic): error: -346 ns, adjusted frequency from 2299774700 Hz to 2299773920 Hz I0229 08:48:41.787933 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:41.788069 2294 parameters.go:238] Clock(Realtime): error: 500 ns, adjusted frequency from 2299774047 Hz to 2299775805 Hz D0229 08:48:41.788200 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:41.788316 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:41.788246 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872678941326392 monotonicBaseRef:80000291783 monotonicFrequency:2299773920 realtimeReady:1 realtimeBaseCycles:8872678942819671 realtimeBaseRef:1582966121788058079 realtimeFrequency:2299775805} D0229 08:48:41.788379 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:41.788543 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:41.788676 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:41.788666 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:41.788748 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:41.788814 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:41.789544 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:41.789700 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:41.789685 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:41.790051 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:41.790249 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:42.787563 2294 parameters.go:238] Clock(Monotonic): error: 606 ns, adjusted frequency from 2299773920 Hz to 2299775961 Hz D0229 08:48:42.787820 2294 parameters.go:238] Clock(Realtime): error: -402 ns, adjusted frequency from 2299775805 Hz to 2299773741 Hz D0229 08:48:42.787986 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872681241409237 monotonicBaseRef:81000426111 monotonicFrequency:2299775961 realtimeReady:1 realtimeBaseCycles:8872681242031384 realtimeBaseRef:1582966122787812797 realtimeFrequency:2299773741} D0229 08:48:43.787418 2294 parameters.go:238] Clock(Monotonic): error: -516 ns, adjusted frequency from 2299775961 Hz to 2299773407 Hz I0229 08:48:43.787543 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:43.787819 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:43.788072 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:43.788129 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:43.787584 2294 parameters.go:238] Clock(Realtime): error: -159 ns, adjusted frequency from 2299773741 Hz to 2299774265 Hz I0229 08:48:43.788234 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:43.788359 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:43.788327 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872683540865419 monotonicBaseRef:82000287063 monotonicFrequency:2299773407 realtimeReady:1 realtimeBaseCycles:8872683541269059 realtimeBaseRef:1582966123787579701 realtimeFrequency:2299774265} D0229 08:48:43.788557 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:43.788716 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:43.910582 10311 main.go:305] *************************** I0229 08:48:43.910722 10311 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-2 /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 /syzkaller928594104] I0229 08:48:43.911168 10311 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 08:48:43.911265 10311 main.go:308] PID: 10311 I0229 08:48:43.911359 10311 main.go:309] UID: 0, GID: 0 I0229 08:48:43.911427 10311 main.go:310] Configuration: I0229 08:48:43.911509 10311 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 08:48:43.911610 10311 main.go:312] Platform: ptrace I0229 08:48:43.911714 10311 main.go:313] FileAccess: shared, overlay: false I0229 08:48:43.911821 10311 main.go:314] Network: sandbox, logging: false I0229 08:48:43.911927 10311 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 08:48:43.912016 10311 main.go:316] *************************** W0229 08:48:43.912103 10311 main.go:321] Block the TERM signal. This is only safe in tests! D0229 08:48:43.912468 10311 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.919057 10311 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0229 08:48:43.919197 10311 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.919309 10311 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.919787 10311 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 08:48:43.919772 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:43.919992 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:43.920129 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:43.920174 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:43.920248 2294 urpc.go:577] urpc: unmarshal success. D0229 08:48:43.920443 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:43.920564 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:43.920559 2294 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0229 08:48:43.920877 2294 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 08:48:43.921118 10311 urpc.go:577] urpc: unmarshal success. D0229 08:48:43.921286 10311 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 /syzkaller928594104 D0229 08:48:43.921401 10311 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0229 08:48:43.921606 10311 container.go:533] Execute in container "ci-gvisor-ptrace-proxy-sandbox-race-2", 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 /syzkaller928594104 D0229 08:48:43.921762 10311 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-2" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.921882 10311 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.922719 10311 urpc.go:534] urpc: successfully marshalled 634 bytes. D0229 08:48:43.923224 2294 urpc.go:577] urpc: unmarshal success. D0229 08:48:43.924392 2294 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 /syzkaller928594104 D0229 08:48:43.924626 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0229 08:48:43.926370 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:43.926532 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 08:48:43.927145 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:43.928064 2294 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 /syzkaller928594104] D0229 08:48:43.929256 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0229 08:48:43.930707 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384223}]} D0229 08:48:43.930981 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0229 08:48:43.931630 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:43.931924 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 08:48:43.932841 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384223}, 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 08:48:43.933069 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalk{FID: 5, NewFID: 6, Names: []} D0229 08:48:43.933794 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rwalk{QIDs: []} D0229 08:48:43.933979 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tlopen{FID: 6, Flags: ReadOnly} D0229 08:48:43.934706 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384223}, IoUnit: 0, File: &{{36}}} I0229 08:48:43.935534 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:43.939479 2294 syscalls.go:266] Allocating stack with size of 8388608 bytes D0229 08:48:43.941206 2294 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-2 0}:0xc00041a6a0 {ci-gvisor-ptrace-proxy-sandbox-race-2 21}:0xc000786700] D0229 08:48:43.941716 2294 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 08:48:43.941710 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:43.941891 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:43.942028 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:43.942045 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:43.942236 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:43.942250 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:43.942378 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:43.942370 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:43.941899 10311 urpc.go:577] urpc: unmarshal success. D0229 08:48:43.942508 10311 container.go:580] Wait on PID 21 in container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.942639 10311 sandbox.go:761] Waiting for PID 21 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.942742 10311 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:43.942795 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:43.942834 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:43.942885 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:43.943027 10311 urpc.go:534] urpc: successfully marshalled 100 bytes. D0229 08:48:43.943021 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:43.943207 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:43.943407 2294 urpc.go:577] urpc: unmarshal success. D0229 08:48:43.943757 2294 controller.go:443] containerManager.Wait D0229 08:48:43.948777 2294 task_block.go:223] [ 21] Interrupt queued I0229 08:48:44.067553 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.067833 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.068042 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.068090 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.068245 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.068371 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.068485 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.068562 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.068650 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.069004 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.069104 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.069139 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.069321 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:44.069427 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:48:44.107722 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.108004 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.108132 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.108278 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.108544 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.108701 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.127524 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.127748 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.127899 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.128043 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.128021 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.128165 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:44.128270 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.128415 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.171582 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.172013 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.172187 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.172295 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.172512 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.172635 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.177506 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.178022 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.178219 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.178334 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.178532 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.178647 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.178708 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.179917 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.179902 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.180095 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.180268 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:44.180534 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.180659 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.180689 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.180908 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:44.181038 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:44.196165 2294 task_block.go:223] [ 22] Interrupt queued D0229 08:48:44.199232 2294 task_block.go:223] [ 23] Interrupt queued D0229 08:48:44.200169 2294 task_block.go:223] [ 24] Interrupt queued D0229 08:48:44.206007 2294 task_block.go:223] [ 25] Interrupt queued D0229 08:48:44.217728 2294 task_block.go:223] [ 26] Interrupt queued D0229 08:48:44.221906 2294 task_block.go:223] [ 27] Interrupt queued D0229 08:48:44.235685 2294 task_block.go:223] [ 28] Interrupt queued D0229 08:48:44.236368 2294 task_block.go:223] [ 29] Interrupt queued D0229 08:48:44.278981 2294 urpc.go:577] urpc: unmarshal success. D0229 08:48:44.279214 2294 controller.go:501] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0229 08:48:44.279458 2294 urpc.go:534] urpc: successfully marshalled 37 bytes. D0229 08:48:44.281791 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0229 08:48:44.282637 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.282835 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 08:48:44.283386 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:44.292076 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.292259 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.292448 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.292524 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.292637 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.292782 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.292970 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.292781 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.293464 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.294112 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.294230 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.294577 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.294596 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.294790 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.294829 2294 task_run.go:152] [ 2] Restarting syscall 202 with restart block after errno 516: not interrupted by handled signal I0229 08:48:44.303017 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.303265 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.303436 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.303501 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.303712 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.303864 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.341585 2294 task_block.go:223] [ 30] Interrupt queued D0229 08:48:44.343581 2294 task_block.go:223] [ 31] Interrupt queued D0229 08:48:44.348710 2294 task_block.go:223] [ 32] Interrupt queued I0229 08:48:44.360309 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.360564 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.360730 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.360866 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.361029 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.361177 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.377331 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.377526 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.377657 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.377751 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.377973 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.378121 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.378726 2294 task_block.go:223] [ 33] Interrupt queued D0229 08:48:44.388118 2294 task_block.go:223] [ 34] Interrupt queued I0229 08:48:44.417521 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.417795 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.417969 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.418085 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.418350 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.418516 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.422224 2294 task_block.go:223] [ 35] Interrupt queued I0229 08:48:44.430182 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.431583 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller928594104]} D0229 08:48:44.431793 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.432966 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.432102 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.433190 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.433239 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 259, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1582966123, NanoSec: 873420968}, MTime: {Sec: 1582966123, NanoSec: 873420968}, CTime: {Sec: 1582966123, NanoSec: 873420968}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384258}]} I0229 08:48:44.433209 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.433369 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.433537 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.433536 2294 task_block.go:223] [ 36] Interrupt queued D0229 08:48:44.433659 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.433621 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller928594104, Size: 1} D0229 08:48:44.434101 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.434205 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.434235 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.434306 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.434442 2294 task_signals.go:176] [ 2] Not restarting syscall 219 after errno 516: interrupted by signal 23 D0229 08:48:44.434618 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:44.434666 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 08:48:44.435755 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384258}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 259, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1582966123, NanoSec: 873420968}, MTime: {Sec: 1582966123, NanoSec: 873420968}, CTime: {Sec: 1582966123, NanoSec: 873420968}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 08:48:44.436167 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalk{FID: 7, NewFID: 8, Names: []} D0229 08:48:44.437065 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rwalk{QIDs: []} D0229 08:48:44.437285 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tlopen{FID: 8, Flags: ReadOnly} D0229 08:48:44.438327 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384258}, IoUnit: 0, File: &{{30}}} D0229 08:48:44.439210 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 08:48:44.440076 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 16384258}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 259, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1582966123, NanoSec: 873420968}, MTime: {Sec: 1582966123, NanoSec: 873420968}, CTime: {Sec: 1582966123, NanoSec: 873420968}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/02/29 08:48:44 parsed 1 programs I0229 08:48:44.446644 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.446849 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.446950 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.447053 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.447329 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.447463 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.450312 2294 task_stop.go:118] [ 23] Entering internal stop (*kernel.vforkStop)(nil) D0229 08:48:44.451093 2294 task_block.go:223] [ 37] Interrupt queued D0229 08:48:44.457537 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0229 08:48:44.459167 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384224}]} D0229 08:48:44.459436 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0229 08:48:44.459944 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.460313 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 08:48:44.461313 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0229 08:48:44.461544 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalk{FID: 9, NewFID: 10, Names: []} I0229 08:48:44.467458 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.467674 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.467833 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.467948 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.468189 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.468363 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.488317 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rwalk{QIDs: []} D0229 08:48:44.488598 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tlopen{FID: 10, Flags: ReadOnly} I0229 08:48:44.490077 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.490317 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.490465 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.490607 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.490792 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.491017 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.492747 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 16384224}, IoUnit: 0, File: &{{31}}} D0229 08:48:44.494095 2294 syscalls.go:266] [ 37] Allocating stack with size of 8388608 bytes D0229 08:48:44.495735 2294 task_stop.go:137] [ 23] Leaving internal stop (*kernel.vforkStop)(nil) D0229 08:48:44.532752 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0229 08:48:44.533420 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.533590 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 08:48:44.534238 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.536296 2294 task_exit.go:221] [ 37] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 08:48:44.536832 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.537111 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.537319 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.537429 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.537655 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.537809 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.537850 2294 task_exit.go:221] [ 37] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 08:48:44.538017 2294 task_signals.go:446] [ 21] Notified of signal 17 D0229 08:48:44.538198 2294 task_block.go:223] [ 21] Interrupt queued D0229 08:48:44.538274 2294 task_block.go:223] [ 21] Interrupt queued D0229 08:48:44.538486 2294 task_signals.go:179] [ 21] Restarting syscall 202 after errno 512: interrupted by signal 17 D0229 08:48:44.538655 2294 task_signals.go:220] [ 21] Signal 17: delivering to handler D0229 08:48:44.538775 2294 task_exit.go:221] [ 37] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 08:48:44.541030 2294 task_block.go:223] [ 38] Interrupt queued D0229 08:48:44.545591 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0229 08:48:44.546980 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384224}]} D0229 08:48:44.547214 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tclunk{FID: 11} D0229 08:48:44.547687 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rclunk{} D0229 08:48:44.548038 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 08:48:44.548995 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/02/29 08:48:44 executed programs: 0 D0229 08:48:44.555145 2294 task_stop.go:118] [ 21] Entering internal stop (*kernel.vforkStop)(nil) I0229 08:48:44.556681 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.557280 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.557642 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.557668 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.557240 2294 task_block.go:223] [ 39] Interrupt queued I0229 08:48:44.557993 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.558036 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.558190 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.558207 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.559573 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.559729 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.559911 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 D0229 08:48:44.560190 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.560290 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.560341 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.560517 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:44.560706 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:48:44.572373 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.572594 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.572701 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.572749 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.572975 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.573097 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.578831 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0229 08:48:44.581296 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 16384224}]} D0229 08:48:44.581488 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tclunk{FID: 11} D0229 08:48:44.582068 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rclunk{} D0229 08:48:44.582329 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0229 08:48:44.583303 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] 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: 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: 1582966043, NanoSec: 221517688}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} I0229 08:48:44.583585 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.583777 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.583905 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.583936 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.584215 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.584398 2294 syscalls.go:266] [ 39] Allocating stack with size of 8388608 bytes D0229 08:48:44.584508 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.585244 2294 task_stop.go:137] [ 21] Leaving internal stop (*kernel.vforkStop)(nil) D0229 08:48:44.592140 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0229 08:48:44.592902 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.593140 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0229 08:48:44.593883 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:44.598966 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.599165 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.599297 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.599294 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.599475 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.599586 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.605852 2294 task_block.go:223] [ 40] Interrupt queued D0229 08:48:44.609325 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.610013 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.610181 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.610709 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.611365 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.612156 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.612333 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.612897 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.613553 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.614202 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.614388 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.614938 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.615433 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.616127 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.616329 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.616860 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.617193 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.617756 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.618041 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.618594 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:44.619175 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.619297 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.619380 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.619538 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.619735 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.619770 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.619974 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.619981 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.620151 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.620471 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.620958 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.621539 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.621691 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.622157 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.622575 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.623121 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.623277 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.623727 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.624303 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.625057 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.625220 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.625733 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:44.639332 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.639503 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.639614 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.639676 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.639868 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.640029 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.656340 2294 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 08:48:44.656560 2294 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 0 D0229 08:48:44.656644 2294 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 0 D0229 08:48:44.656712 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.656790 2294 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 08:48:44.657332 2294 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 08:48:44.657469 2294 netfilter.go:54] netfilter: convert to binary: found hook 2 at offset 152 D0229 08:48:44.657578 2294 netfilter.go:54] netfilter: convert to binary: found underflow 2 at offset 152 D0229 08:48:44.657696 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.657855 2294 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 08:48:44.658400 2294 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 08:48:44.658510 2294 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0229 08:48:44.658592 2294 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0229 08:48:44.658748 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.658903 2294 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 08:48:44.659472 2294 netfilter.go:54] netfilter: convert to binary: current offset: 456 I0229 08:48:44.659665 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.659919 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.659580 2294 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 08:48:44.660127 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.660232 2294 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0229 08:48:44.660365 2294 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 08:48:44.660232 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.660450 2294 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0229 08:48:44.660621 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.660708 2294 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0229 08:48:44.661017 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.660950 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.661119 2294 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 08:48:44.661740 2294 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 08:48:44.661829 2294 netfilter.go:54] netfilter: convert to binary: found hook 1 at offset 152 D0229 08:48:44.661984 2294 netfilter.go:54] netfilter: convert to binary: found underflow 1 at offset 152 D0229 08:48:44.662063 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.662143 2294 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 08:48:44.662669 2294 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 08:48:44.662739 2294 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 304 D0229 08:48:44.662895 2294 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 304 D0229 08:48:44.662974 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.663085 2294 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 08:48:44.663585 2294 netfilter.go:54] netfilter: convert to binary: current offset: 456 D0229 08:48:44.663674 2294 netfilter.go:54] netfilter: convert to binary: found hook 4 at offset 456 D0229 08:48:44.663779 2294 netfilter.go:54] netfilter: convert to binary: found underflow 4 at offset 456 D0229 08:48:44.663893 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.663989 2294 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 08:48:44.664477 2294 netfilter.go:54] netfilter: convert to binary: current offset: 608 D0229 08:48:44.664607 2294 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 08:48:44.665332 2294 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 D0229 08:48:44.665429 2294 netfilter.go:54] netfilter: convert to binary: current offset: 0 D0229 08:48:44.665525 2294 netfilter.go:54] netfilter: convert to binary: found hook 0 at offset 0 D0229 08:48:44.665628 2294 netfilter.go:54] netfilter: convert to binary: found underflow 0 at offset 0 D0229 08:48:44.665732 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.665837 2294 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 08:48:44.666359 2294 netfilter.go:54] netfilter: convert to binary: current offset: 152 D0229 08:48:44.666469 2294 netfilter.go:54] netfilter: convert to binary: found hook 3 at offset 152 D0229 08:48:44.666541 2294 netfilter.go:54] netfilter: convert to binary: found underflow 3 at offset 152 D0229 08:48:44.666648 2294 netfilter.go:54] netfilter: convert to binary: marshalling standard target D0229 08:48:44.666754 2294 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 08:48:44.667338 2294 netfilter.go:54] netfilter: convert to binary: current offset: 304 D0229 08:48:44.667470 2294 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 08:48:44.668278 2294 netfilter.go:54] netfilter: convert to binary: finished with an marshalled size of 0 I0229 08:48:44.679779 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.680035 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.680149 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.680259 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.680469 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.680613 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.690996 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.692114 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.693218 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.692234 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.693540 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.693629 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.693763 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.693802 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.693910 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.694228 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.694349 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.694340 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.694578 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:44.694723 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler I0229 08:48:44.710146 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.710317 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.710455 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.710583 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.710839 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.710983 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.726565 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.726873 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.727034 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.727185 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.727538 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.727649 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.746924 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.747142 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.747296 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.747438 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.747643 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.747775 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.763526 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.763820 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.763978 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.764105 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.764345 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.764511 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.773724 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.773927 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.774018 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.774190 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.774394 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.774562 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.788438 2294 parameters.go:238] Clock(Monotonic): error: 362 ns, adjusted frequency from 2299773407 Hz to 2299775553 Hz D0229 08:48:44.788725 2294 parameters.go:238] Clock(Realtime): error: 222 ns, adjusted frequency from 2299774265 Hz to 2299775110 Hz D0229 08:48:44.788870 2294 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:8872685842989049 monotonicBaseRef:83001308999 monotonicFrequency:2299775553 realtimeReady:1 realtimeBaseCycles:8872685843661593 realtimeBaseRef:1582966124788718190 realtimeFrequency:2299775110} I0229 08:48:44.790071 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.790306 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.790488 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.790504 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.790682 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.790828 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.810399 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.810649 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.810809 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.810865 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.811086 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.811234 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.821658 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.821933 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.822089 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.822148 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.822381 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.822507 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.839939 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.840213 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.840346 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.840468 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.840763 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.840915 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.860089 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.860368 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.860557 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.860627 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.860903 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.861155 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.880295 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.880505 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.880617 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.880747 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.880992 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.881137 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler I0229 08:48:44.900579 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.900883 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.901081 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.901184 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.901493 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.901664 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.920154 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.921089 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.921230 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.921924 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.922293 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.923046 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.923273 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.924162 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.924624 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.925195 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.925419 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.926054 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:44.926489 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.926513 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.926695 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.926834 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.926980 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.927065 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.927223 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.927294 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.927458 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.927943 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.928485 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.929058 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.929227 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.929714 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.930104 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.930799 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.930937 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.931474 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.931923 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.932483 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.932709 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.933247 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.933923 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.934559 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.934790 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.935270 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.935637 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.936400 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.936869 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.937404 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:44.937771 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:44.938385 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:44.938515 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:44.939031 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:44.946745 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.947077 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.947168 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.947285 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.947498 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.947620 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.960447 2294 task_block.go:223] [ 41] Interrupt queued I0229 08:48:44.974369 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.973324 2294 task_block.go:223] [ 42] Interrupt queued D0229 08:48:44.975055 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.975961 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.975828 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.976450 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 I0229 08:48:44.976483 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.976745 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.976859 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.977002 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.977438 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.977606 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0229 08:48:44.977802 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.977967 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0229 08:48:44.978129 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.978290 2294 task_signals.go:434] [ 1] Discarding duplicate signal 23 I0229 08:48:44.980289 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.981772 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.981804 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.981915 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.982091 2294 task_signals.go:176] [ 2] Not restarting syscall 202 after errno 516: interrupted by signal 23 D0229 08:48:44.982230 2294 task_signals.go:220] [ 2] Signal 23: delivering to handler D0229 08:48:44.982215 2294 task_signals.go:452] [ 2] Notified of group signal 23 D0229 08:48:44.982373 2294 task_block.go:223] [ 2] Interrupt queued D0229 08:48:44.982569 2294 task_block.go:223] [ 1] Interrupt queued I0229 08:48:44.982582 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:44.982748 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:44.982878 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:44.983040 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.983607 2294 task_block.go:223] [ 3] Interrupt queued D0229 08:48:44.983545 2294 task_block.go:223] [ 3] Interrupt queued D0229 08:48:44.983941 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:44.984202 2294 task_signals.go:179] [ 3] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:44.984452 2294 task_signals.go:220] [ 3] Signal 23: delivering to handler D0229 08:48:45.007436 2294 task_block.go:223] [ 43] Interrupt queued D0229 08:48:45.020424 2294 task_block.go:223] [ 42] Interrupt queued D0229 08:48:45.020481 2294 task_block.go:223] [ 42] Interrupt queued D0229 08:48:45.020647 2294 task_block.go:223] [ 43] Interrupt queued D0229 08:48:45.020708 2294 task_block.go:223] [ 43] Interrupt queued D0229 08:48:45.020769 2294 task_exit.go:221] [ 41] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 08:48:45.020909 2294 task_signals.go:189] [ 43] Signal 9: terminating thread group D0229 08:48:45.020988 2294 task_signals.go:189] [ 42] Signal 9: terminating thread group I0229 08:48:45.021019 2294 compat.go:129] Uncaught signal: "killed" (9), PID: 41, TID: 43, fault addr: 0x0 D0229 08:48:45.021025 2294 task_exit.go:221] [ 41] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 08:48:45.021412 2294 task_exit.go:221] [ 43] Transitioning from exit state TaskExitNone to TaskExitInitiated I0229 08:48:45.021630 2294 compat.go:129] Uncaught signal: "killed" (9), PID: 41, TID: 42, fault addr: 0x0 D0229 08:48:45.021799 2294 task_exit.go:221] [ 42] Transitioning from exit state TaskExitNone to TaskExitInitiated D0229 08:48:45.022115 2294 task_exit.go:221] [ 43] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 08:48:45.022304 2294 task_exit.go:221] [ 43] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 08:48:45.023581 2294 task_exit.go:221] [ 42] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0229 08:48:45.023709 2294 task_exit.go:221] [ 42] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 08:48:45.023903 2294 task_signals.go:419] [ 40] Discarding ignored signal 17 D0229 08:48:45.024737 2294 task_exit.go:221] [ 41] Transitioning from exit state TaskExitZombie to TaskExitDead D0229 08:48:45.028652 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:45.029336 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:45.029571 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:45.030231 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:45.031065 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:45.031702 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:45.031952 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:45.032547 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} D0229 08:48:45.033257 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0229 08:48:45.034196 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 2} D0229 08:48:45.035133 2294 transport_flipcall.go:127] send [channel @0xc0004463c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0229 08:48:45.035772 2294 transport_flipcall.go:234] recv [channel @0xc0004463c0] Rlerror{Error: 95} I0229 08:48:45.040389 2294 loader.go:566] Received external signal 23, mode: Process D0229 08:48:45.040679 2294 task_signals.go:446] [ 1] Notified of signal 23 D0229 08:48:45.041052 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:45.041304 2294 task_block.go:223] [ 1] Interrupt queued D0229 08:48:45.041590 2294 task_signals.go:179] [ 1] Restarting syscall 202 after errno 512: interrupted by signal 23 D0229 08:48:45.041913 2294 task_signals.go:220] [ 1] Signal 23: delivering to handler D0229 08:48:45.044393 2294 task_block.go:223] [ 44] Interrupt queued D0229 08:48:45.053568 2294 task_block.go:223] [ 45] Interrupt queued D0229 08:48:45.068412 2294 task_block.go:223] [ 46] Interrupt queued ================== WARNING: DATA RACE Read at 0x00c0001a8b50 by goroutine 367: 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 DIAGNOSIS: I0229 08:48:45.108606 10545 main.go:305] *************************** I0229 08:48:45.108765 10545 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-2] I0229 08:48:45.108932 10545 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 08:48:45.109012 10545 main.go:308] PID: 10545 I0229 08:48:45.109119 10545 main.go:309] UID: 0, GID: 0 I0229 08:48:45.109243 10545 main.go:310] Configuration: I0229 08:48:45.109325 10545 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 08:48:45.109399 10545 main.go:312] Platform: ptrace I0229 08:48:45.109508 10545 main.go:313] FileAccess: shared, overlay: false I0229 08:48:45.109647 10545 main.go:314] Network: sandbox, logging: false I0229 08:48:45.109751 10545 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 08:48:45.109842 10545 main.go:316] *************************** W0229 08:48:45.109911 10545 main.go:321] Block the TERM signal. This is only safe in tests! D0229 08:48:45.110038 10545 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.116363 10545 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0229 08:48:45.116539 10545 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.116611 10545 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.117159 10545 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 08:48:45.204740 10545 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 2294 I0229 08:48:45.204944 10545 debug.go:131] Retrieving sandbox stacks D0229 08:48:45.205092 10545 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.205250 10545 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0229 08:48:45.205459 10545 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 2294: connection refused retrieving stacks: connecting to control server at PID 2294: connection refused W0229 08:48:45.205724 10545 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-2"]: exit status 128 I0229 08:48:45.108606 10545 main.go:305] *************************** I0229 08:48:45.108765 10545 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-2] I0229 08:48:45.108932 10545 main.go:307] Version release-20200219.0-72-gce4d1e45bb88 I0229 08:48:45.109012 10545 main.go:308] PID: 10545 I0229 08:48:45.109119 10545 main.go:309] UID: 0, GID: 0 I0229 08:48:45.109243 10545 main.go:310] Configuration: I0229 08:48:45.109325 10545 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0229 08:48:45.109399 10545 main.go:312] Platform: ptrace I0229 08:48:45.109508 10545 main.go:313] FileAccess: shared, overlay: false I0229 08:48:45.109647 10545 main.go:314] Network: sandbox, logging: false I0229 08:48:45.109751 10545 main.go:315] Strace: false, max size: 1024, syscalls: [] I0229 08:48:45.109842 10545 main.go:316] *************************** W0229 08:48:45.109911 10545 main.go:321] Block the TERM signal. This is only safe in tests! D0229 08:48:45.110038 10545 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.116363 10545 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0229 08:48:45.116539 10545 sandbox.go:806] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.116611 10545 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.117159 10545 urpc.go:534] urpc: successfully marshalled 117 bytes. I0229 08:48:45.204740 10545 debug.go:122] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 2294 I0229 08:48:45.204944 10545 debug.go:131] Retrieving sandbox stacks D0229 08:48:45.205092 10545 sandbox.go:924] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.205250 10545 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0229 08:48:45.205459 10545 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 2294: connection refused retrieving stacks: connecting to control server at PID 2294: connection refused W0229 08:48:45.205724 10545 main.go:338] Failure to execute command, err: 1 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 Previous write at 0x00c0001a8b50 by goroutine 376: gvisor.dev/gvisor/pkg/tcpip/transport/udp.(*endpoint).bindLocked() pkg/tcpip/transport/udp/endpoint.go:1176 +0x27c gvisor.dev/gvisor/pkg/tcpip/transport/udp.(*endpoint).prepareForWrite() pkg/tcpip/transport/udp/endpoint.go:323 +0x26d gvisor.dev/gvisor/pkg/tcpip/transport/udp.(*endpoint).write() pkg/tcpip/transport/udp/endpoint.go:400 +0x12b gvisor.dev/gvisor/pkg/tcpip/transport/udp.(*endpoint).Write() pkg/tcpip/transport/udp/endpoint.go:360 +0x81 gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).Write() pkg/sentry/socket/netstack/netstack.go:522 +0x152 gvisor.dev/gvisor/pkg/sentry/fs.(*File).Writev() pkg/sentry/fs/file.go:336 +0x308 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.writev() pkg/sentry/syscalls/linux/sys_write.go:262 +0xe0 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Write() pkg/sentry/syscalls/linux/sys_write.go:72 +0x2ab gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall() pkg/sentry/kernel/task_syscall.go:170 +0x44d gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke() pkg/sentry/kernel/task_syscall.go:291 +0xb4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter() pkg/sentry/kernel/task_syscall.go:252 +0x109 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall() pkg/sentry/kernel/task_syscall.go:227 +0x1b3 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute() pkg/sentry/kernel/task_run.go:232 +0x1aaa gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run() pkg/sentry/kernel/task_run.go:92 +0x320 Goroutine 367 (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 376 (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 08:48:45.196381 10311 error.go:48] FATAL ERROR: waiting on pid 21: waiting on PID 21 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2": urpc method "containerManager.WaitPID" failed: EOF waiting on pid 21: waiting on PID 21 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2": urpc method "containerManager.WaitPID" failed: EOF W0229 08:48:45.196841 10311 main.go:338] Failure to execute command, err: 1 W0229 08:48:45.204708 2278 sandbox.go:742] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-2" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D0229 08:48:45.205148 2278 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.205375 2278 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.205522 2278 sandbox.go:1058] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-2" by destroying sandbox D0229 08:48:45.205683 2278 sandbox.go:788] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0229 08:48:45.205834 2278 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 2287 I0229 08:48:45.407491 2278 main.go:329] Exiting with status: 16896