D0327 14:33:15.072606 54333 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0327 14:33:15.072995 54333 parameters.go:238] Clock(Monotonic): error: 554 ns, adjusted frequency from 2299774319 Hz to 2299775595 Hz D0327 14:33:15.073206 54333 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0327 14:33:15.073309 54333 parameters.go:238] Clock(Realtime): error: 467 ns, adjusted frequency from 2299774202 Hz to 2299775371 Hz D0327 14:33:15.073466 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922781647169837 monotonicBaseRef:2000670352 monotonicFrequency:2299775595 realtimeReady:1 realtimeBaseCycles:2922781647930918 realtimeBaseRef:1585319595073302378 realtimeFrequency:2299775371} D0327 14:33:16.072695 54333 parameters.go:238] Clock(Monotonic): error: -470 ns, adjusted frequency from 2299775595 Hz to 2299773362 Hz D0327 14:33:16.072924 54333 parameters.go:238] Clock(Realtime): error: -247 ns, adjusted frequency from 2299775371 Hz to 2299773677 Hz D0327 14:33:16.073045 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922783946271918 monotonicBaseRef:3000377491 monotonicFrequency:2299773362 realtimeReady:1 realtimeBaseCycles:2922783946822047 realtimeBaseRef:1585319596072917887 realtimeFrequency:2299773677} D0327 14:33:17.072698 54333 parameters.go:238] Clock(Monotonic): error: 689 ns, adjusted frequency from 2299773362 Hz to 2299775974 Hz D0327 14:33:17.073025 54333 parameters.go:238] Clock(Realtime): error: 375 ns, adjusted frequency from 2299773677 Hz to 2299775364 Hz D0327 14:33:17.073202 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922786245909131 monotonicBaseRef:4000318289 monotonicFrequency:2299775974 realtimeReady:1 realtimeBaseCycles:2922786246824052 realtimeBaseRef:1585319597073017169 realtimeFrequency:2299775364} D0327 14:33:18.072747 54333 parameters.go:238] Clock(Monotonic): error: -235 ns, adjusted frequency from 2299775974 Hz to 2299774011 Hz D0327 14:33:18.073001 54333 parameters.go:238] Clock(Realtime): error: 251 ns, adjusted frequency from 2299775364 Hz to 2299774904 Hz D0327 14:33:18.073199 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922788545924856 monotonicBaseRef:5000422538 monotonicFrequency:2299774011 realtimeReady:1 realtimeBaseCycles:2922788546547497 realtimeBaseRef:1585319598072994593 realtimeFrequency:2299774904} D0327 14:33:19.072686 54333 parameters.go:238] Clock(Monotonic): error: -32 ns, adjusted frequency from 2299774011 Hz to 2299774467 Hz D0327 14:33:19.072946 54333 parameters.go:238] Clock(Realtime): error: -200 ns, adjusted frequency from 2299774904 Hz to 2299774044 Hz D0327 14:33:19.073086 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922790845554298 monotonicBaseRef:6000359675 monotonicFrequency:2299774467 realtimeReady:1 realtimeBaseCycles:2922790846180191 realtimeBaseRef:1585319599072932756 realtimeFrequency:2299774044} D0327 14:33:20.072770 54333 parameters.go:238] Clock(Monotonic): error: 1 ns, adjusted frequency from 2299774467 Hz to 2299774533 Hz D0327 14:33:20.073060 54333 parameters.go:238] Clock(Realtime): error: 110 ns, adjusted frequency from 2299774044 Hz to 2299774642 Hz D0327 14:33:20.073234 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922793145523231 monotonicBaseRef:7000444233 monotonicFrequency:2299774533 realtimeReady:1 realtimeBaseCycles:2922793146231559 realtimeBaseRef:1585319600073053343 realtimeFrequency:2299774642} D0327 14:33:21.072704 54333 parameters.go:238] Clock(Monotonic): error: -89 ns, adjusted frequency from 2299774533 Hz to 2299774262 Hz D0327 14:33:21.072938 54333 parameters.go:238] Clock(Realtime): error: 124 ns, adjusted frequency from 2299774642 Hz to 2299774737 Hz D0327 14:33:21.073091 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922795445084268 monotonicBaseRef:8000351399 monotonicFrequency:2299774262 realtimeReady:1 realtimeBaseCycles:2922795445725995 realtimeBaseRef:1585319601072931502 realtimeFrequency:2299774737} D0327 14:33:22.072644 54333 parameters.go:238] Clock(Monotonic): error: 528 ns, adjusted frequency from 2299774262 Hz to 2299775646 Hz D0327 14:33:22.072936 54333 parameters.go:238] Clock(Realtime): error: 215 ns, adjusted frequency from 2299774737 Hz to 2299774929 Hz D0327 14:33:22.073091 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922797744783683 monotonicBaseRef:9000318853 monotonicFrequency:2299775646 realtimeReady:1 realtimeBaseCycles:2922797745492738 realtimeBaseRef:1585319602072928026 realtimeFrequency:2299774929} D0327 14:33:23.072682 54333 parameters.go:238] Clock(Monotonic): error: -329 ns, adjusted frequency from 2299775646 Hz to 2299773820 Hz D0327 14:33:23.072942 54333 parameters.go:238] Clock(Realtime): error: 77 ns, adjusted frequency from 2299774929 Hz to 2299774703 Hz D0327 14:33:23.073149 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922800044655431 monotonicBaseRef:10000360640 monotonicFrequency:2299773820 realtimeReady:1 realtimeBaseCycles:2922800045283831 realtimeBaseRef:1585319603072935054 realtimeFrequency:2299774703} D0327 14:33:24.072683 54333 parameters.go:238] Clock(Monotonic): error: 20 ns, adjusted frequency from 2299773820 Hz to 2299774652 Hz D0327 14:33:24.072931 54333 parameters.go:238] Clock(Realtime): error: -178 ns, adjusted frequency from 2299774703 Hz to 2299774139 Hz D0327 14:33:24.073053 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922802344306742 monotonicBaseRef:11000307369 monotonicFrequency:2299774652 realtimeReady:1 realtimeBaseCycles:2922802345034646 realtimeBaseRef:1585319604072924666 realtimeFrequency:2299774139} D0327 14:33:25.072737 54333 parameters.go:238] Clock(Monotonic): error: -61 ns, adjusted frequency from 2299774652 Hz to 2299774456 Hz D0327 14:33:25.073138 54333 parameters.go:238] Clock(Realtime): error: -78 ns, adjusted frequency from 2299774139 Hz to 2299774439 Hz D0327 14:33:25.073284 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922804644299707 monotonicBaseRef:12000402296 monotonicFrequency:2299774456 realtimeReady:1 realtimeBaseCycles:2922804645279441 realtimeBaseRef:1585319605073129319 realtimeFrequency:2299774439} D0327 14:33:26.072692 54333 parameters.go:238] Clock(Monotonic): error: 68 ns, adjusted frequency from 2299774456 Hz to 2299774795 Hz D0327 14:33:26.072975 54333 parameters.go:238] Clock(Realtime): error: -104 ns, adjusted frequency from 2299774439 Hz to 2299774307 Hz D0327 14:33:26.073133 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922806943994393 monotonicBaseRef:13000367609 monotonicFrequency:2299774795 realtimeReady:1 realtimeBaseCycles:2922806944668621 realtimeBaseRef:1585319606072961798 realtimeFrequency:2299774307} D0327 14:33:27.072603 54333 parameters.go:238] Clock(Monotonic): error: -92 ns, adjusted frequency from 2299774795 Hz to 2299774343 Hz D0327 14:33:27.072933 54333 parameters.go:238] Clock(Realtime): error: 384 ns, adjusted frequency from 2299774307 Hz to 2299775506 Hz D0327 14:33:27.073086 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922809243553768 monotonicBaseRef:14000273938 monotonicFrequency:2299774343 realtimeReady:1 realtimeBaseCycles:2922809244359239 realtimeBaseRef:1585319607072925407 realtimeFrequency:2299775506} D0327 14:33:28.072790 54333 parameters.go:238] Clock(Monotonic): error: 432 ns, adjusted frequency from 2299774343 Hz to 2299775493 Hz D0327 14:33:28.073127 54333 parameters.go:238] Clock(Realtime): error: 65 ns, adjusted frequency from 2299775506 Hz to 2299774657 Hz D0327 14:33:28.073333 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922811543768514 monotonicBaseRef:15000465436 monotonicFrequency:2299775493 realtimeReady:1 realtimeBaseCycles:2922811544579247 realtimeBaseRef:1585319608073118687 realtimeFrequency:2299774657} D0327 14:33:29.072682 54333 parameters.go:238] Clock(Monotonic): error: -630 ns, adjusted frequency from 2299775493 Hz to 2299773114 Hz D0327 14:33:29.072930 54333 parameters.go:238] Clock(Realtime): error: 14 ns, adjusted frequency from 2299774657 Hz to 2299774630 Hz D0327 14:33:29.073074 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922813843241675 monotonicBaseRef:16000333974 monotonicFrequency:2299773114 realtimeReady:1 realtimeBaseCycles:2922813843897504 realtimeBaseRef:1585319609072920232 realtimeFrequency:2299774630} D0327 14:33:30.072669 54333 parameters.go:238] Clock(Monotonic): error: 600 ns, adjusted frequency from 2299773114 Hz to 2299776008 Hz D0327 14:33:30.073008 54333 parameters.go:238] Clock(Realtime): error: 2 ns, adjusted frequency from 2299774630 Hz to 2299774584 Hz D0327 14:33:30.073134 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922816143044214 monotonicBaseRef:17000346768 monotonicFrequency:2299776008 realtimeReady:1 realtimeBaseCycles:2922816143853502 realtimeBaseRef:1585319610072999095 realtimeFrequency:2299774584} D0327 14:33:31.072850 54333 parameters.go:238] Clock(Monotonic): error: -359 ns, adjusted frequency from 2299776008 Hz to 2299773820 Hz D0327 14:33:31.073199 54333 parameters.go:238] Clock(Realtime): error: -172 ns, adjusted frequency from 2299774584 Hz to 2299774184 Hz D0327 14:33:31.073449 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922818443239621 monotonicBaseRef:18000529133 monotonicFrequency:2299773820 realtimeReady:1 realtimeBaseCycles:2922818444033922 realtimeBaseRef:1585319611073175562 realtimeFrequency:2299774184} D0327 14:33:32.072591 54333 parameters.go:238] Clock(Monotonic): error: -229 ns, adjusted frequency from 2299773820 Hz to 2299774034 Hz D0327 14:33:32.072812 54333 parameters.go:238] Clock(Realtime): error: -189 ns, adjusted frequency from 2299774184 Hz to 2299774150 Hz D0327 14:33:32.072950 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922820742421474 monotonicBaseRef:19000271730 monotonicFrequency:2299774034 realtimeReady:1 realtimeBaseCycles:2922820742959014 realtimeBaseRef:1585319612072806355 realtimeFrequency:2299774150} D0327 14:33:33.072642 54333 parameters.go:238] Clock(Monotonic): error: 124 ns, adjusted frequency from 2299774034 Hz to 2299774849 Hz D0327 14:33:33.072927 54333 parameters.go:238] Clock(Realtime): error: 596 ns, adjusted frequency from 2299774150 Hz to 2299775986 Hz D0327 14:33:33.073133 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922823042311099 monotonicBaseRef:20000321991 monotonicFrequency:2299774849 realtimeReady:1 realtimeBaseCycles:2922823042991234 realtimeBaseRef:1585319613072918570 realtimeFrequency:2299775986} D0327 14:33:34.072816 54333 parameters.go:238] Clock(Monotonic): error: -27 ns, adjusted frequency from 2299774849 Hz to 2299774504 Hz D0327 14:33:34.073057 54333 parameters.go:238] Clock(Realtime): error: -478 ns, adjusted frequency from 2299775986 Hz to 2299773396 Hz D0327 14:33:34.073191 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922825342476871 monotonicBaseRef:21000491974 monotonicFrequency:2299774504 realtimeReady:1 realtimeBaseCycles:2922825343058847 realtimeBaseRef:1585319614073045376 realtimeFrequency:2299773396} D0327 14:33:35.072638 54333 parameters.go:238] Clock(Monotonic): error: 113 ns, adjusted frequency from 2299774504 Hz to 2299774828 Hz D0327 14:33:35.072872 54333 parameters.go:238] Clock(Realtime): error: 582 ns, adjusted frequency from 2299773396 Hz to 2299775885 Hz D0327 14:33:35.073040 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922827641834220 monotonicBaseRef:22000310584 monotonicFrequency:2299774828 realtimeReady:1 realtimeBaseCycles:2922827642419756 realtimeBaseRef:1585319615072866016 realtimeFrequency:2299775885} D0327 14:33:36.072674 54333 parameters.go:238] Clock(Monotonic): error: 123 ns, adjusted frequency from 2299774828 Hz to 2299774739 Hz D0327 14:33:36.072891 54333 parameters.go:238] Clock(Realtime): error: -899 ns, adjusted frequency from 2299775885 Hz to 2299772537 Hz D0327 14:33:36.073025 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922829941695021 monotonicBaseRef:23000347967 monotonicFrequency:2299774739 realtimeReady:1 realtimeBaseCycles:2922829942238375 realtimeBaseRef:1585319616072884597 realtimeFrequency:2299772537} D0327 14:33:37.072625 54333 parameters.go:238] Clock(Monotonic): error: 122 ns, adjusted frequency from 2299774739 Hz to 2299774947 Hz D0327 14:33:37.072906 54333 parameters.go:238] Clock(Realtime): error: 159 ns, adjusted frequency from 2299772537 Hz to 2299774942 Hz D0327 14:33:37.073089 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922832241357635 monotonicBaseRef:24000299212 monotonicFrequency:2299774947 realtimeReady:1 realtimeBaseCycles:2922832242042354 realtimeBaseRef:1585319617072898268 realtimeFrequency:2299774942} D0327 14:33:38.072602 54333 parameters.go:238] Clock(Monotonic): error: -234 ns, adjusted frequency from 2299774947 Hz to 2299774042 Hz D0327 14:33:38.072897 54333 parameters.go:238] Clock(Realtime): error: 93 ns, adjusted frequency from 2299774942 Hz to 2299774859 Hz D0327 14:33:38.073093 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922834541080721 monotonicBaseRef:25000276661 monotonicFrequency:2299774042 realtimeReady:1 realtimeBaseCycles:2922834541796453 realtimeBaseRef:1585319618072889204 realtimeFrequency:2299774859} D0327 14:33:39.072584 54333 parameters.go:238] Clock(Monotonic): error: -56 ns, adjusted frequency from 2299774042 Hz to 2299774455 Hz D0327 14:33:39.072885 54333 parameters.go:238] Clock(Realtime): error: 357 ns, adjusted frequency from 2299774859 Hz to 2299775391 Hz D0327 14:33:39.073070 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922836840793167 monotonicBaseRef:26000249877 monotonicFrequency:2299774455 realtimeReady:1 realtimeBaseCycles:2922836841542275 realtimeBaseRef:1585319619072876577 realtimeFrequency:2299775391} D0327 14:33:40.072504 54333 parameters.go:238] Clock(Monotonic): error: 74 ns, adjusted frequency from 2299774455 Hz to 2299774760 Hz D0327 14:33:40.072809 54333 parameters.go:238] Clock(Realtime): error: -86 ns, adjusted frequency from 2299775391 Hz to 2299774431 Hz D0327 14:33:40.072960 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922839140417204 monotonicBaseRef:27000184471 monotonicFrequency:2299774760 realtimeReady:1 realtimeBaseCycles:2922839141145695 realtimeBaseRef:1585319620072801799 realtimeFrequency:2299774431} D0327 14:33:41.072629 54333 parameters.go:238] Clock(Monotonic): error: -304 ns, adjusted frequency from 2299774760 Hz to 2299773865 Hz D0327 14:33:41.072812 54333 parameters.go:238] Clock(Realtime): error: -364 ns, adjusted frequency from 2299774431 Hz to 2299773684 Hz D0327 14:33:41.072926 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922841440487483 monotonicBaseRef:28000312970 monotonicFrequency:2299773865 realtimeReady:1 realtimeBaseCycles:2922841440931275 realtimeBaseRef:1585319621072806646 realtimeFrequency:2299773684} D0327 14:33:42.072670 54333 parameters.go:238] Clock(Monotonic): error: 21 ns, adjusted frequency from 2299773865 Hz to 2299774608 Hz D0327 14:33:42.072949 54333 parameters.go:238] Clock(Realtime): error: 347 ns, adjusted frequency from 2299773684 Hz to 2299775330 Hz D0327 14:33:42.073120 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922843740342538 monotonicBaseRef:29000348273 monotonicFrequency:2299774608 realtimeReady:1 realtimeBaseCycles:2922843741014700 realtimeBaseRef:1585319622072941329 realtimeFrequency:2299775330} D0327 14:33:43.072618 54333 parameters.go:238] Clock(Monotonic): error: 446 ns, adjusted frequency from 2299774608 Hz to 2299775455 Hz D0327 14:33:43.072851 54333 parameters.go:238] Clock(Realtime): error: -31 ns, adjusted frequency from 2299775330 Hz to 2299774544 Hz D0327 14:33:43.073153 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922846040002054 monotonicBaseRef:30000298228 monotonicFrequency:2299775455 realtimeReady:1 realtimeBaseCycles:2922846040565528 realtimeBaseRef:1585319623072843709 realtimeFrequency:2299774544} D0327 14:33:44.072668 54333 parameters.go:238] Clock(Monotonic): error: 258 ns, adjusted frequency from 2299775455 Hz to 2299775204 Hz D0327 14:33:44.072996 54333 parameters.go:238] Clock(Realtime): error: 11 ns, adjusted frequency from 2299774544 Hz to 2299774593 Hz D0327 14:33:44.073144 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922848339865882 monotonicBaseRef:31000336654 monotonicFrequency:2299775204 realtimeReady:1 realtimeBaseCycles:2922848340672760 realtimeBaseRef:1585319624072988370 realtimeFrequency:2299774593} D0327 14:33:45.072631 54333 parameters.go:238] Clock(Monotonic): error: -422 ns, adjusted frequency from 2299775204 Hz to 2299773721 Hz D0327 14:33:45.072945 54333 parameters.go:238] Clock(Realtime): error: 40 ns, adjusted frequency from 2299774593 Hz to 2299774575 Hz D0327 14:33:45.073192 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922850639581554 monotonicBaseRef:32000310767 monotonicFrequency:2299773721 realtimeReady:1 realtimeBaseCycles:2922850640328500 realtimeBaseRef:1585319625072936689 realtimeFrequency:2299774575} D0327 14:33:46.072875 54333 parameters.go:238] Clock(Monotonic): error: -43 ns, adjusted frequency from 2299773721 Hz to 2299774449 Hz D0327 14:33:46.073172 54333 parameters.go:238] Clock(Realtime): error: 121 ns, adjusted frequency from 2299774575 Hz to 2299774876 Hz D0327 14:33:46.073402 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922852939891142 monotonicBaseRef:33000543775 monotonicFrequency:2299774449 realtimeReady:1 realtimeBaseCycles:2922852940622107 realtimeBaseRef:1585319626073162377 realtimeFrequency:2299774876} D0327 14:33:47.072633 54333 parameters.go:238] Clock(Monotonic): error: 36 ns, adjusted frequency from 2299774449 Hz to 2299774672 Hz D0327 14:33:47.072886 54333 parameters.go:238] Clock(Realtime): error: -3 ns, adjusted frequency from 2299774876 Hz to 2299774541 Hz D0327 14:33:47.073115 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922855239135823 monotonicBaseRef:34000313418 monotonicFrequency:2299774672 realtimeReady:1 realtimeBaseCycles:2922855239731892 realtimeBaseRef:1585319627072873178 realtimeFrequency:2299774541} D0327 14:33:48.049553 54333 urpc.go:577] urpc: unmarshal success. D0327 14:33:48.049873 54333 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0327 14:33:48.050250 54333 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 14:33:48.072561 54333 parameters.go:238] Clock(Monotonic): error: -84 ns, adjusted frequency from 2299774672 Hz to 2299774375 Hz D0327 14:33:48.072842 54333 parameters.go:238] Clock(Realtime): error: -472 ns, adjusted frequency from 2299774541 Hz to 2299773541 Hz D0327 14:33:48.073049 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922857538740682 monotonicBaseRef:35000239579 monotonicFrequency:2299774375 realtimeReady:1 realtimeBaseCycles:2922857539412499 realtimeBaseRef:1585319628072832333 realtimeFrequency:2299773541} D0327 14:33:49.072833 54333 parameters.go:238] Clock(Monotonic): error: 84 ns, adjusted frequency from 2299774375 Hz to 2299774783 Hz D0327 14:33:49.073069 54333 parameters.go:238] Clock(Realtime): error: 234 ns, adjusted frequency from 2299773541 Hz to 2299775076 Hz D0327 14:33:49.073204 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922859839136322 monotonicBaseRef:36000509720 monotonicFrequency:2299774783 realtimeReady:1 realtimeBaseCycles:2922859839710484 realtimeBaseRef:1585319629073060374 realtimeFrequency:2299775076} D0327 14:33:50.072491 54333 parameters.go:238] Clock(Monotonic): error: -291 ns, adjusted frequency from 2299774783 Hz to 2299773904 Hz D0327 14:33:50.072757 54333 parameters.go:238] Clock(Realtime): error: -159 ns, adjusted frequency from 2299775076 Hz to 2299774201 Hz D0327 14:33:50.072847 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922862138138038 monotonicBaseRef:37000173570 monotonicFrequency:2299773904 realtimeReady:1 realtimeBaseCycles:2922862138772210 realtimeBaseRef:1585319630072750191 realtimeFrequency:2299774201} D0327 14:33:51.072571 54333 parameters.go:238] Clock(Monotonic): error: 270 ns, adjusted frequency from 2299773904 Hz to 2299775215 Hz D0327 14:33:51.072874 54333 parameters.go:238] Clock(Realtime): error: 162 ns, adjusted frequency from 2299774201 Hz to 2299774920 Hz D0327 14:33:51.073046 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922864438089947 monotonicBaseRef:38000250971 monotonicFrequency:2299775215 realtimeReady:1 realtimeBaseCycles:2922864438814547 realtimeBaseRef:1585319631072866783 realtimeFrequency:2299774920} D0327 14:33:52.072624 54333 parameters.go:238] Clock(Monotonic): error: 324 ns, adjusted frequency from 2299775215 Hz to 2299775475 Hz D0327 14:33:52.072903 54333 parameters.go:238] Clock(Realtime): error: 95 ns, adjusted frequency from 2299774920 Hz to 2299774801 Hz D0327 14:33:52.073053 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922866737986586 monotonicBaseRef:39000303769 monotonicFrequency:2299775475 realtimeReady:1 realtimeBaseCycles:2922866738653130 realtimeBaseRef:1585319632072894465 realtimeFrequency:2299774801} D0327 14:33:53.072607 54333 parameters.go:238] Clock(Monotonic): error: -686 ns, adjusted frequency from 2299775475 Hz to 2299772911 Hz D0327 14:33:53.072900 54333 parameters.go:238] Clock(Realtime): error: 0 ns, adjusted frequency from 2299774801 Hz to 2299774554 Hz D0327 14:33:53.073048 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922869037732779 monotonicBaseRef:40000291036 monotonicFrequency:2299772911 realtimeReady:1 realtimeBaseCycles:2922869038423380 realtimeBaseRef:1585319633072892486 realtimeFrequency:2299774554} D0327 14:33:54.072642 54333 parameters.go:238] Clock(Monotonic): error: 271 ns, adjusted frequency from 2299772911 Hz to 2299775183 Hz D0327 14:33:54.072918 54333 parameters.go:238] Clock(Realtime): error: 197 ns, adjusted frequency from 2299774554 Hz to 2299775046 Hz D0327 14:33:54.073083 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922871337575612 monotonicBaseRef:41000321439 monotonicFrequency:2299775183 realtimeReady:1 realtimeBaseCycles:2922871338239640 realtimeBaseRef:1585319634072910620 realtimeFrequency:2299775046} D0327 14:33:55.072730 54333 parameters.go:238] Clock(Monotonic): error: 241 ns, adjusted frequency from 2299775183 Hz to 2299775002 Hz D0327 14:33:55.072935 54333 parameters.go:238] Clock(Realtime): error: -278 ns, adjusted frequency from 2299775046 Hz to 2299773933 Hz D0327 14:33:55.073109 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922873637535060 monotonicBaseRef:42000401562 monotonicFrequency:2299775002 realtimeReady:1 realtimeBaseCycles:2922873638055934 realtimeBaseRef:1585319635072928555 realtimeFrequency:2299773933} D0327 14:33:56.072614 54333 parameters.go:238] Clock(Monotonic): error: -30 ns, adjusted frequency from 2299775002 Hz to 2299774409 Hz D0327 14:33:56.072889 54333 parameters.go:238] Clock(Realtime): error: 38 ns, adjusted frequency from 2299773933 Hz to 2299774608 Hz D0327 14:33:56.073091 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922875937047924 monotonicBaseRef:43000287577 monotonicFrequency:2299774409 realtimeReady:1 realtimeBaseCycles:2922875937723973 realtimeBaseRef:1585319636072882509 realtimeFrequency:2299774608} D0327 14:33:57.072672 54333 parameters.go:238] Clock(Monotonic): error: -353 ns, adjusted frequency from 2299774409 Hz to 2299773744 Hz D0327 14:33:57.072959 54333 parameters.go:238] Clock(Realtime): error: 8 ns, adjusted frequency from 2299774608 Hz to 2299774532 Hz D0327 14:33:57.073185 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922878236946865 monotonicBaseRef:44000341726 monotonicFrequency:2299773744 realtimeReady:1 realtimeBaseCycles:2922878237657417 realtimeBaseRef:1585319637072951574 realtimeFrequency:2299774532} D0327 14:33:58.072629 54333 parameters.go:238] Clock(Monotonic): error: -1 ns, adjusted frequency from 2299773744 Hz to 2299774555 Hz D0327 14:33:58.072841 54333 parameters.go:238] Clock(Realtime): error: -155 ns, adjusted frequency from 2299774532 Hz to 2299774239 Hz D0327 14:33:58.072934 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922880536654808 monotonicBaseRef:45000313114 monotonicFrequency:2299774555 realtimeReady:1 realtimeBaseCycles:2922880537165201 realtimeBaseRef:1585319638072835585 realtimeFrequency:2299774239} I0327 14:33:58.248106 54333 watchdog.go:277] Watchdog starting loop, tasks: 16, discount: 0s D0327 14:33:59.072784 54333 parameters.go:238] Clock(Monotonic): error: 281 ns, adjusted frequency from 2299774555 Hz to 2299775209 Hz D0327 14:33:59.073000 54333 parameters.go:238] Clock(Realtime): error: -111 ns, adjusted frequency from 2299774239 Hz to 2299774403 Hz D0327 14:33:59.073204 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922882836659467 monotonicBaseRef:46000413169 monotonicFrequency:2299775209 realtimeReady:1 realtimeBaseCycles:2922882837294720 realtimeBaseRef:1585319639072990069 realtimeFrequency:2299774403} D0327 14:34:00.072641 54333 parameters.go:238] Clock(Monotonic): error: -24 ns, adjusted frequency from 2299775209 Hz to 2299774486 Hz D0327 14:34:00.072942 54333 parameters.go:238] Clock(Realtime): error: 202 ns, adjusted frequency from 2299774403 Hz to 2299774945 Hz D0327 14:34:00.073108 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922885136212915 monotonicBaseRef:47000316741 monotonicFrequency:2299774486 realtimeReady:1 realtimeBaseCycles:2922885136931843 realtimeBaseRef:1585319640072930376 realtimeFrequency:2299774945} D0327 14:34:01.072640 54333 parameters.go:238] Clock(Monotonic): error: 772 ns, adjusted frequency from 2299774486 Hz to 2299776316 Hz D0327 14:34:01.072886 54333 parameters.go:238] Clock(Realtime): error: -13 ns, adjusted frequency from 2299774945 Hz to 2299774536 Hz D0327 14:34:01.073007 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922887435990782 monotonicBaseRef:48000318211 monotonicFrequency:2299776316 realtimeReady:1 realtimeBaseCycles:2922887436590556 realtimeBaseRef:1585319641072879835 realtimeFrequency:2299774536} D0327 14:34:02.072595 54333 parameters.go:238] Clock(Monotonic): error: -805 ns, adjusted frequency from 2299776316 Hz to 2299772746 Hz D0327 14:34:02.072899 54333 parameters.go:238] Clock(Realtime): error: 130 ns, adjusted frequency from 2299774536 Hz to 2299774798 Hz D0327 14:34:02.073110 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922889735666134 monotonicBaseRef:49000274309 monotonicFrequency:2299772746 realtimeReady:1 realtimeBaseCycles:2922889736390669 realtimeBaseRef:1585319642072890956 realtimeFrequency:2299774798} D0327 14:34:03.006293 54333 urpc.go:577] urpc: unmarshal success. D0327 14:34:03.006603 54333 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0327 14:34:03.006956 54333 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 14:34:03.072662 54333 parameters.go:238] Clock(Monotonic): error: 315 ns, adjusted frequency from 2299772746 Hz to 2299775176 Hz D0327 14:34:03.073019 54333 parameters.go:238] Clock(Realtime): error: 264 ns, adjusted frequency from 2299774798 Hz to 2299775231 Hz D0327 14:34:03.073218 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922892035586742 monotonicBaseRef:50000338603 monotonicFrequency:2299775176 realtimeReady:1 realtimeBaseCycles:2922892036442557 realtimeBaseRef:1585319643073011441 realtimeFrequency:2299775231} D0327 14:34:04.072690 54333 parameters.go:238] Clock(Monotonic): error: -206 ns, adjusted frequency from 2299775176 Hz to 2299774210 Hz D0327 14:34:04.072945 54333 parameters.go:238] Clock(Realtime): error: -383 ns, adjusted frequency from 2299775231 Hz to 2299773591 Hz D0327 14:34:04.075053 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922894335279425 monotonicBaseRef:51000302732 monotonicFrequency:2299774210 realtimeReady:1 realtimeBaseCycles:2922894336048221 realtimeBaseRef:1585319644072937709 realtimeFrequency:2299773591} D0327 14:34:05.072705 54333 parameters.go:238] Clock(Monotonic): error: -129 ns, adjusted frequency from 2299774210 Hz to 2299774335 Hz D0327 14:34:05.072924 54333 parameters.go:238] Clock(Realtime): error: -116 ns, adjusted frequency from 2299773591 Hz to 2299774321 Hz D0327 14:34:05.073070 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922896635217239 monotonicBaseRef:52000373871 monotonicFrequency:2299774335 realtimeReady:1 realtimeBaseCycles:2922896635777496 realtimeBaseRef:1585319645072918439 realtimeFrequency:2299774321} D0327 14:34:06.072650 54333 parameters.go:238] Clock(Monotonic): error: 35 ns, adjusted frequency from 2299774335 Hz to 2299774666 Hz D0327 14:34:06.072948 54333 parameters.go:238] Clock(Realtime): error: 315 ns, adjusted frequency from 2299774321 Hz to 2299775317 Hz D0327 14:34:06.073112 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922898934864511 monotonicBaseRef:53000318620 monotonicFrequency:2299774666 realtimeReady:1 realtimeBaseCycles:2922898935602904 realtimeBaseRef:1585319646072940652 realtimeFrequency:2299775317} D0327 14:34:07.072441 54333 parameters.go:238] Clock(Monotonic): error: -204 ns, adjusted frequency from 2299774666 Hz to 2299774105 Hz D0327 14:34:07.072757 54333 parameters.go:238] Clock(Realtime): error: -312 ns, adjusted frequency from 2299775317 Hz to 2299773874 Hz D0327 14:34:07.072891 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922901234186393 monotonicBaseRef:54000121738 monotonicFrequency:2299774105 realtimeReady:1 realtimeBaseCycles:2922901234936878 realtimeBaseRef:1585319647072748744 realtimeFrequency:2299773874} D0327 14:34:08.072640 54333 parameters.go:238] Clock(Monotonic): error: -29 ns, adjusted frequency from 2299774105 Hz to 2299774511 Hz D0327 14:34:08.072856 54333 parameters.go:238] Clock(Realtime): error: -54 ns, adjusted frequency from 2299773874 Hz to 2299774386 Hz D0327 14:34:08.073020 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922903534404057 monotonicBaseRef:55000314608 monotonicFrequency:2299774511 realtimeReady:1 realtimeBaseCycles:2922903534945792 realtimeBaseRef:1585319648072850945 realtimeFrequency:2299774386} D0327 14:34:09.072742 54333 parameters.go:238] Clock(Monotonic): error: 185 ns, adjusted frequency from 2299774511 Hz to 2299775013 Hz D0327 14:34:09.073048 54333 parameters.go:238] Clock(Realtime): error: 311 ns, adjusted frequency from 2299774386 Hz to 2299775307 Hz D0327 14:34:09.073272 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922905834409103 monotonicBaseRef:56000414850 monotonicFrequency:2299775013 realtimeReady:1 realtimeBaseCycles:2922905835139362 realtimeBaseRef:1585319649073033216 realtimeFrequency:2299775307} D0327 14:34:10.072599 54333 sampler.go:197] Time: Adjusting syscall overhead down to 7000 D0327 14:34:10.072808 54333 parameters.go:238] Clock(Monotonic): error: -90 ns, adjusted frequency from 2299775013 Hz to 2299774366 Hz D0327 14:34:10.072972 54333 parameters.go:238] Clock(Realtime): error: -121 ns, adjusted frequency from 2299775307 Hz to 2299774260 Hz D0327 14:34:10.073151 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922908133874166 monotonicBaseRef:57000280075 monotonicFrequency:2299774366 realtimeReady:1 realtimeBaseCycles:2922908134754458 realtimeBaseRef:1585319650072963552 realtimeFrequency:2299774260} D0327 14:34:11.072665 54333 parameters.go:238] Clock(Monotonic): error: 172 ns, adjusted frequency from 2299774366 Hz to 2299774986 Hz D0327 14:34:11.072933 54333 parameters.go:238] Clock(Realtime): error: -104 ns, adjusted frequency from 2299774260 Hz to 2299774362 Hz D0327 14:34:11.073090 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922910433785358 monotonicBaseRef:58000339570 monotonicFrequency:2299774986 realtimeReady:1 realtimeBaseCycles:2922910434444112 realtimeBaseRef:1585319651072926763 realtimeFrequency:2299774362} D0327 14:34:12.072648 54333 parameters.go:238] Clock(Monotonic): error: 121 ns, adjusted frequency from 2299774986 Hz to 2299774952 Hz D0327 14:34:12.072998 54333 parameters.go:238] Clock(Realtime): error: 23 ns, adjusted frequency from 2299774362 Hz to 2299774526 Hz D0327 14:34:12.073104 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922912733517915 monotonicBaseRef:59000321120 monotonicFrequency:2299774952 realtimeReady:1 realtimeBaseCycles:2922912734364623 realtimeBaseRef:1585319652072990312 realtimeFrequency:2299774526} D0327 14:34:13.072803 54333 parameters.go:238] Clock(Monotonic): error: -98 ns, adjusted frequency from 2299774952 Hz to 2299774298 Hz D0327 14:34:13.073065 54333 parameters.go:238] Clock(Realtime): error: 262 ns, adjusted frequency from 2299774526 Hz to 2299775216 Hz D0327 14:34:13.073268 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922915033667416 monotonicBaseRef:60000483983 monotonicFrequency:2299774298 realtimeReady:1 realtimeBaseCycles:2922915034281383 realtimeBaseRef:1585319653073052158 realtimeFrequency:2299775216} D0327 14:34:14.072585 54333 parameters.go:238] Clock(Monotonic): error: -338 ns, adjusted frequency from 2299774298 Hz to 2299773798 Hz D0327 14:34:14.072831 54333 parameters.go:238] Clock(Realtime): error: -291 ns, adjusted frequency from 2299775216 Hz to 2299773893 Hz D0327 14:34:14.072966 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922917332942872 monotonicBaseRef:61000267073 monotonicFrequency:2299773798 realtimeReady:1 realtimeBaseCycles:2922917333521776 realtimeBaseRef:1585319654072819603 realtimeFrequency:2299773893} D0327 14:34:15.072647 54333 parameters.go:238] Clock(Monotonic): error: 384 ns, adjusted frequency from 2299773798 Hz to 2299775344 Hz D0327 14:34:15.072884 54333 parameters.go:238] Clock(Realtime): error: -29 ns, adjusted frequency from 2299773893 Hz to 2299774486 Hz D0327 14:34:15.072971 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922919632785202 monotonicBaseRef:62000296872 monotonicFrequency:2299775344 realtimeReady:1 realtimeBaseCycles:2922919633432428 realtimeBaseRef:1585319655072879069 realtimeFrequency:2299774486} D0327 14:34:16.072640 54333 parameters.go:238] Clock(Monotonic): error: -338 ns, adjusted frequency from 2299775344 Hz to 2299773792 Hz D0327 14:34:16.072936 54333 parameters.go:238] Clock(Realtime): error: 412 ns, adjusted frequency from 2299774486 Hz to 2299775523 Hz D0327 14:34:16.073127 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922921932598320 monotonicBaseRef:63000313297 monotonicFrequency:2299773792 realtimeReady:1 realtimeBaseCycles:2922921933321379 realtimeBaseRef:1585319656072928841 realtimeFrequency:2299775523} D0327 14:34:17.072640 54333 parameters.go:238] Clock(Monotonic): error: -20 ns, adjusted frequency from 2299773792 Hz to 2299774521 Hz D0327 14:34:17.073093 54333 parameters.go:238] Clock(Realtime): error: -369 ns, adjusted frequency from 2299775523 Hz to 2299773783 Hz D0327 14:34:17.073259 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922924232377282 monotonicBaseRef:64000315545 monotonicFrequency:2299774521 realtimeReady:1 realtimeBaseCycles:2922924233450380 realtimeBaseRef:1585319657073082542 realtimeFrequency:2299773783} D0327 14:34:18.072571 54333 parameters.go:238] Clock(Monotonic): error: 410 ns, adjusted frequency from 2299774521 Hz to 2299775521 Hz D0327 14:34:18.072876 54333 parameters.go:238] Clock(Realtime): error: 237 ns, adjusted frequency from 2299773783 Hz to 2299775141 Hz D0327 14:34:18.073055 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922926531999716 monotonicBaseRef:65000249413 monotonicFrequency:2299775521 realtimeReady:1 realtimeBaseCycles:2922926532728899 realtimeBaseRef:1585319658072867188 realtimeFrequency:2299775141} D0327 14:34:19.072691 54333 parameters.go:238] Clock(Monotonic): error: -379 ns, adjusted frequency from 2299775521 Hz to 2299773682 Hz D0327 14:34:19.072944 54333 parameters.go:238] Clock(Realtime): error: -110 ns, adjusted frequency from 2299775141 Hz to 2299774318 Hz D0327 14:34:19.073056 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922928831987139 monotonicBaseRef:66000341553 monotonicFrequency:2299773682 realtimeReady:1 realtimeBaseCycles:2922928832662077 realtimeBaseRef:1585319659072935906 realtimeFrequency:2299774318} D0327 14:34:20.072595 54333 parameters.go:238] Clock(Monotonic): error: 340 ns, adjusted frequency from 2299773682 Hz to 2299775343 Hz D0327 14:34:20.072915 54333 parameters.go:238] Clock(Realtime): error: 124 ns, adjusted frequency from 2299774318 Hz to 2299774875 Hz D0327 14:34:20.073105 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922931131605289 monotonicBaseRef:67000273923 monotonicFrequency:2299775343 realtimeReady:1 realtimeBaseCycles:2922931132365866 realtimeBaseRef:1585319660072905238 realtimeFrequency:2299774875} D0327 14:34:21.073538 54333 parameters.go:238] Clock(Monotonic): error: 6 ns, adjusted frequency from 2299775343 Hz to 2299774628 Hz D0327 14:34:21.073816 54333 parameters.go:238] Clock(Realtime): error: 78 ns, adjusted frequency from 2299774875 Hz to 2299774784 Hz D0327 14:34:21.073982 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922933433549206 monotonicBaseRef:68001216873 monotonicFrequency:2299774628 realtimeReady:1 realtimeBaseCycles:2922933434215009 realtimeBaseRef:1585319661073807181 realtimeFrequency:2299774784} D0327 14:34:22.072602 54333 parameters.go:238] Clock(Monotonic): error: -393 ns, adjusted frequency from 2299774628 Hz to 2299773699 Hz D0327 14:34:22.072824 54333 parameters.go:238] Clock(Realtime): error: -386 ns, adjusted frequency from 2299774784 Hz to 2299773731 Hz D0327 14:34:22.072924 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922935731173874 monotonicBaseRef:69000282016 monotonicFrequency:2299773699 realtimeReady:1 realtimeBaseCycles:2922935731715933 realtimeBaseRef:1585319662072818449 realtimeFrequency:2299773731} D0327 14:34:23.072711 54333 parameters.go:238] Clock(Monotonic): error: 295 ns, adjusted frequency from 2299773699 Hz to 2299775266 Hz D0327 14:34:23.073008 54333 parameters.go:238] Clock(Realtime): error: -66 ns, adjusted frequency from 2299773731 Hz to 2299774480 Hz D0327 14:34:23.073229 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922938031180415 monotonicBaseRef:70000383261 monotonicFrequency:2299775266 realtimeReady:1 realtimeBaseCycles:2922938031905897 realtimeBaseRef:1585319663072999437 realtimeFrequency:2299774480} D0327 14:34:24.072653 54333 parameters.go:238] Clock(Monotonic): error: -159 ns, adjusted frequency from 2299775266 Hz to 2299774299 Hz D0327 14:34:24.072918 54333 parameters.go:238] Clock(Realtime): error: 132 ns, adjusted frequency from 2299774480 Hz to 2299774825 Hz D0327 14:34:24.073037 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922940330841049 monotonicBaseRef:71000333416 monotonicFrequency:2299774299 realtimeReady:1 realtimeBaseCycles:2922940331476407 realtimeBaseRef:1585319664072910745 realtimeFrequency:2299774825} D0327 14:34:25.072585 54333 parameters.go:238] Clock(Monotonic): error: -33 ns, adjusted frequency from 2299774299 Hz to 2299774355 Hz D0327 14:34:25.072814 54333 parameters.go:238] Clock(Realtime): error: -97 ns, adjusted frequency from 2299774825 Hz to 2299774298 Hz D0327 14:34:25.072949 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922942630456167 monotonicBaseRef:72000264200 monotonicFrequency:2299774355 realtimeReady:1 realtimeBaseCycles:2922942631016397 realtimeBaseRef:1585319665072808632 realtimeFrequency:2299774298} D0327 14:34:26.072748 54333 parameters.go:238] Clock(Monotonic): error: 128 ns, adjusted frequency from 2299774355 Hz to 2299774876 Hz D0327 14:34:26.072996 54333 parameters.go:238] Clock(Realtime): error: 248 ns, adjusted frequency from 2299774298 Hz to 2299775059 Hz D0327 14:34:26.073166 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922944930595504 monotonicBaseRef:73000422903 monotonicFrequency:2299774876 realtimeReady:1 realtimeBaseCycles:2922944931204523 realtimeBaseRef:1585319666072988574 realtimeFrequency:2299775059} D0327 14:34:27.072647 54333 parameters.go:238] Clock(Monotonic): error: 193 ns, adjusted frequency from 2299774876 Hz to 2299775038 Hz D0327 14:34:27.072943 54333 parameters.go:238] Clock(Realtime): error: 175 ns, adjusted frequency from 2299775059 Hz to 2299775020 Hz D0327 14:34:27.073104 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922947230150263 monotonicBaseRef:74000327190 monotonicFrequency:2299775038 realtimeReady:1 realtimeBaseCycles:2922947230854383 realtimeBaseRef:1585319667072934134 realtimeFrequency:2299775020} D0327 14:34:28.072639 54333 parameters.go:238] Clock(Monotonic): error: -162 ns, adjusted frequency from 2299775038 Hz to 2299774214 Hz D0327 14:34:28.072938 54333 parameters.go:238] Clock(Realtime): error: -362 ns, adjusted frequency from 2299775020 Hz to 2299773715 Hz D0327 14:34:28.073062 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922949529906935 monotonicBaseRef:75000319204 monotonicFrequency:2299774214 realtimeReady:1 realtimeBaseCycles:2922949530623471 realtimeBaseRef:1585319668072931554 realtimeFrequency:2299773715} D0327 14:34:29.072593 54333 parameters.go:238] Clock(Monotonic): error: 46 ns, adjusted frequency from 2299774214 Hz to 2299774556 Hz D0327 14:34:29.072867 54333 parameters.go:238] Clock(Realtime): error: -292 ns, adjusted frequency from 2299773715 Hz to 2299773960 Hz D0327 14:34:29.073053 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922951829574933 monotonicBaseRef:76000273018 monotonicFrequency:2299774556 realtimeReady:1 realtimeBaseCycles:2922951830217131 realtimeBaseRef:1585319669072853261 realtimeFrequency:2299773960} D0327 14:34:30.072630 54333 parameters.go:238] Clock(Monotonic): error: -243 ns, adjusted frequency from 2299774556 Hz to 2299773952 Hz D0327 14:34:30.072935 54333 parameters.go:238] Clock(Realtime): error: 208 ns, adjusted frequency from 2299773960 Hz to 2299775077 Hz D0327 14:34:30.073122 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922954129441454 monotonicBaseRef:77000313006 monotonicFrequency:2299773952 realtimeReady:1 realtimeBaseCycles:2922954130168252 realtimeBaseRef:1585319670072930295 realtimeFrequency:2299775077} D0327 14:34:31.072737 54333 parameters.go:238] Clock(Monotonic): error: 241 ns, adjusted frequency from 2299773952 Hz to 2299775132 Hz D0327 14:34:31.073026 54333 parameters.go:238] Clock(Realtime): error: -3 ns, adjusted frequency from 2299775077 Hz to 2299774602 Hz D0327 14:34:31.073187 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922956429398193 monotonicBaseRef:78000392486 monotonicFrequency:2299775132 realtimeReady:1 realtimeBaseCycles:2922956430144939 realtimeBaseRef:1585319671073017960 realtimeFrequency:2299774602} D0327 14:34:32.072640 54333 parameters.go:238] Clock(Monotonic): error: 75 ns, adjusted frequency from 2299775132 Hz to 2299774754 Hz D0327 14:34:32.072946 54333 parameters.go:238] Clock(Realtime): error: 240 ns, adjusted frequency from 2299774602 Hz to 2299775019 Hz D0327 14:34:32.073103 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922958729002703 monotonicBaseRef:79000318295 monotonicFrequency:2299774754 realtimeReady:1 realtimeBaseCycles:2922958729735250 realtimeBaseRef:1585319672072937825 realtimeFrequency:2299775019} D0327 14:34:33.072737 54333 parameters.go:238] Clock(Monotonic): error: -39 ns, adjusted frequency from 2299774754 Hz to 2299774504 Hz D0327 14:34:33.073035 54333 parameters.go:238] Clock(Realtime): error: 38 ns, adjusted frequency from 2299775019 Hz to 2299774687 Hz D0327 14:34:33.073231 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922961028966185 monotonicBaseRef:80000400358 monotonicFrequency:2299774504 realtimeReady:1 realtimeBaseCycles:2922961029715658 realtimeBaseRef:1585319673073027133 realtimeFrequency:2299774687} D0327 14:34:34.072621 54333 parameters.go:238] Clock(Monotonic): error: -128 ns, adjusted frequency from 2299774504 Hz to 2299774378 Hz D0327 14:34:34.072916 54333 parameters.go:238] Clock(Realtime): error: 97 ns, adjusted frequency from 2299774687 Hz to 2299774814 Hz D0327 14:34:34.073081 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922963328509153 monotonicBaseRef:81000299680 monotonicFrequency:2299774378 realtimeReady:1 realtimeBaseCycles:2922963329216269 realtimeBaseRef:1585319674072907957 realtimeFrequency:2299774814} D0327 14:34:35.072918 54333 parameters.go:238] Clock(Monotonic): error: 54 ns, adjusted frequency from 2299774378 Hz to 2299774698 Hz D0327 14:34:35.073198 54333 parameters.go:238] Clock(Realtime): error: -57 ns, adjusted frequency from 2299774814 Hz to 2299774453 Hz D0327 14:34:35.073370 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922965628936725 monotonicBaseRef:82000583705 monotonicFrequency:2299774698 realtimeReady:1 realtimeBaseCycles:2922965629640421 realtimeBaseRef:1585319675073190305 realtimeFrequency:2299774453} D0327 14:34:36.072627 54333 parameters.go:238] Clock(Monotonic): error: -115 ns, adjusted frequency from 2299774698 Hz to 2299774208 Hz D0327 14:34:36.072893 54333 parameters.go:238] Clock(Realtime): error: -51 ns, adjusted frequency from 2299774453 Hz to 2299774457 Hz D0327 14:34:36.073057 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922967928056803 monotonicBaseRef:83000299059 monotonicFrequency:2299774208 realtimeReady:1 realtimeBaseCycles:2922967928712918 realtimeBaseRef:1585319676072885076 realtimeFrequency:2299774457} D0327 14:34:37.072619 54333 parameters.go:238] Clock(Monotonic): error: 106 ns, adjusted frequency from 2299774208 Hz to 2299774820 Hz D0327 14:34:37.072873 54333 parameters.go:238] Clock(Realtime): error: -324 ns, adjusted frequency from 2299774457 Hz to 2299773921 Hz D0327 14:34:37.072991 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922970227823018 monotonicBaseRef:84000295583 monotonicFrequency:2299774820 realtimeReady:1 realtimeBaseCycles:2922970228441708 realtimeBaseRef:1585319677072865218 realtimeFrequency:2299773921} I0327 14:34:37.340485 55075 main.go:305] *************************** I0327 14:34:37.340662 55075 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot exec -user=0:0 -cap CAP_CHOWN -cap CAP_DAC_OVERRIDE -cap CAP_DAC_READ_SEARCH -cap CAP_FOWNER -cap CAP_FSETID -cap CAP_KILL -cap CAP_SETGID -cap CAP_SETUID -cap CAP_SETPCAP -cap CAP_LINUX_IMMUTABLE -cap CAP_NET_BIND_SERVICE -cap CAP_NET_BROADCAST -cap CAP_NET_ADMIN -cap CAP_NET_RAW -cap CAP_IPC_LOCK -cap CAP_IPC_OWNER -cap CAP_SYS_MODULE -cap CAP_SYS_RAWIO -cap CAP_SYS_CHROOT -cap CAP_SYS_PTRACE -cap CAP_SYS_PACCT -cap CAP_SYS_ADMIN -cap CAP_SYS_BOOT -cap CAP_SYS_NICE -cap CAP_SYS_RESOURCE -cap CAP_SYS_TIME -cap CAP_SYS_TTY_CONFIG -cap CAP_MKNOD -cap CAP_LEASE -cap CAP_AUDIT_WRITE -cap CAP_AUDIT_CONTROL -cap CAP_SETFCAP -cap CAP_MAC_OVERRIDE -cap CAP_MAC_ADMIN -cap CAP_SYSLOG -cap CAP_WAKE_ALARM -cap CAP_BLOCK_SUSPEND -cap CAP_AUDIT_READ ci-gvisor-ptrace-proxy-sandbox-race-0 /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller772174829] I0327 14:34:37.341157 55075 main.go:307] Version release-20200219.0-252-g76a7ace751bf I0327 14:34:37.341236 55075 main.go:308] PID: 55075 I0327 14:34:37.341332 55075 main.go:309] UID: 0, GID: 0 I0327 14:34:37.341426 55075 main.go:310] Configuration: I0327 14:34:37.341510 55075 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0327 14:34:37.341599 55075 main.go:312] Platform: ptrace I0327 14:34:37.341688 55075 main.go:313] FileAccess: shared, overlay: false I0327 14:34:37.341820 55075 main.go:314] Network: sandbox, logging: false I0327 14:34:37.341921 55075 main.go:315] Strace: false, max size: 1024, syscalls: [] I0327 14:34:37.342009 55075 main.go:316] *************************** W0327 14:34:37.342093 55075 main.go:321] Block the TERM signal. This is only safe in tests! D0327 14:34:37.342597 55075 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.349355 55075 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0327 14:34:37.349585 55075 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.349719 55075 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.350146 55075 urpc.go:534] urpc: successfully marshalled 117 bytes. D0327 14:34:37.350588 54333 urpc.go:577] urpc: unmarshal success. D0327 14:34:37.350922 54333 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0327 14:34:37.351329 54333 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 14:34:37.351599 55075 urpc.go:577] urpc: unmarshal success. D0327 14:34:37.351824 55075 exec.go:120] Exec arguments: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller772174829 D0327 14:34:37.352053 55075 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0327 14:34:37.352270 55075 container.go:533] Execute in container "ci-gvisor-ptrace-proxy-sandbox-race-0", args: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller772174829 D0327 14:34:37.352495 55075 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-0" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.352765 55075 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.353786 55075 urpc.go:534] urpc: successfully marshalled 636 bytes. D0327 14:34:37.354252 54333 urpc.go:577] urpc: unmarshal success. D0327 14:34:37.355860 54333 controller.go:270] containerManager.ExecuteAsync: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller772174829 D0327 14:34:37.356101 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0327 14:34:37.356950 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:37.357166 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 14:34:37.357747 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} I0327 14:34:37.358357 54333 kernel.go:807] EXEC: [/syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller772174829] D0327 14:34:37.359354 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0327 14:34:37.360916 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] 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: 24180480, BlockSize: 4096, Blocks: 47232, ATime: {Sec: 1585284953, NanoSec: 68927262}, MTime: {Sec: 1585284953, NanoSec: 68927262}, CTime: {Sec: 1585319594, NanoSec: 375946263}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398869}]} D0327 14:34:37.361135 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0327 14:34:37.361735 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:37.362036 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 14:34:37.363545 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19398869}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 24180480, BlockSize: 4096, Blocks: 47232, ATime: {Sec: 1585284953, NanoSec: 68927262}, MTime: {Sec: 1585284953, NanoSec: 68927262}, CTime: {Sec: 1585319594, NanoSec: 375946263}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 14:34:37.363732 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalk{FID: 5, NewFID: 6, Names: []} D0327 14:34:37.364763 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rwalk{QIDs: []} D0327 14:34:37.364939 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tlopen{FID: 6, Flags: ReadOnly} D0327 14:34:37.366096 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19398869}, IoUnit: 0, File: &{{37}}} D0327 14:34:37.370958 54333 syscalls.go:266] Allocating stack with size of 8388608 bytes D0327 14:34:37.377395 54333 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-0 0}:0xc000124840 {ci-gvisor-ptrace-proxy-sandbox-race-0 22}:0xc000125840] D0327 14:34:37.378117 54333 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 14:34:37.378477 55075 urpc.go:577] urpc: unmarshal success. D0327 14:34:37.378823 55075 container.go:580] Wait on PID 22 in container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.379065 55075 sandbox.go:769] Waiting for PID 22 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.379225 55075 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:37.380130 55075 urpc.go:534] urpc: successfully marshalled 100 bytes. D0327 14:34:37.380380 54333 urpc.go:577] urpc: unmarshal success. D0327 14:34:37.380699 54333 controller.go:446] containerManager.Wait D0327 14:34:37.386044 54333 task_block.go:223] [ 22] Interrupt queued D0327 14:34:37.587882 54333 task_block.go:223] [ 23] Interrupt queued D0327 14:34:37.588773 54333 task_block.go:223] [ 24] Interrupt queued D0327 14:34:37.595019 54333 task_block.go:223] [ 25] Interrupt queued D0327 14:34:37.602048 54333 task_block.go:223] [ 26] Interrupt queued D0327 14:34:37.621073 54333 task_block.go:223] [ 27] Interrupt queued D0327 14:34:37.627827 54333 task_block.go:223] [ 28] Interrupt queued D0327 14:34:37.678355 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0327 14:34:37.679093 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:37.679298 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 14:34:37.679941 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:37.702154 54333 task_block.go:223] [ 29] Interrupt queued D0327 14:34:37.713020 54333 task_block.go:223] [ 30] Interrupt queued D0327 14:34:37.716348 54333 urpc.go:577] urpc: unmarshal success. D0327 14:34:37.716667 54333 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-0 Signo:0 PID:0 Mode:Process} D0327 14:34:37.717145 54333 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 14:34:37.739249 54333 task_block.go:223] [ 31] Interrupt queued D0327 14:34:37.757725 54333 task_block.go:223] [ 32] Interrupt queued D0327 14:34:37.805517 54333 task_block.go:223] [ 33] Interrupt queued D0327 14:34:37.822976 54333 task_block.go:223] [ 34] Interrupt queued D0327 14:34:37.872823 54333 task_block.go:223] [ 35] Interrupt queued D0327 14:34:37.884349 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller772174829]} D0327 14:34:37.884455 54333 task_block.go:223] [ 36] Interrupt queued D0327 14:34:37.886140 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] 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: 389, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1585319677, NanoSec: 304074269}, MTime: {Sec: 1585319677, NanoSec: 304074269}, CTime: {Sec: 1585319677, NanoSec: 304074269}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398682}]} D0327 14:34:37.886512 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller772174829, Size: 1} D0327 14:34:37.887458 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:37.887945 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 14:34:37.889463 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19398682}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 389, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1585319677, NanoSec: 304074269}, MTime: {Sec: 1585319677, NanoSec: 304074269}, CTime: {Sec: 1585319677, NanoSec: 304074269}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 14:34:37.889786 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalk{FID: 7, NewFID: 8, Names: []} D0327 14:34:37.890732 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rwalk{QIDs: []} D0327 14:34:37.890998 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tlopen{FID: 8, Flags: ReadOnly} D0327 14:34:37.892089 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19398682}, IoUnit: 0, File: &{{31}}} D0327 14:34:37.893842 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 14:34:37.895332 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19398682}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 389, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1585319677, NanoSec: 304074269}, MTime: {Sec: 1585319677, NanoSec: 304074269}, CTime: {Sec: 1585319677, NanoSec: 304074269}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/27 14:34:37 parsed 1 programs D0327 14:34:37.913410 54333 task_stop.go:118] [ 36] Entering internal stop (*kernel.vforkStop)(nil) D0327 14:34:37.914502 54333 task_block.go:223] [ 37] Interrupt queued D0327 14:34:37.921143 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0327 14:34:37.923237 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] 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: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1585284953, NanoSec: 496969216}, MTime: {Sec: 1585284953, NanoSec: 496969216}, CTime: {Sec: 1585319594, NanoSec: 379946655}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398870}]} D0327 14:34:37.923704 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0327 14:34:37.924426 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:37.924801 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 14:34:37.925910 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19398870}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1585284953, NanoSec: 496969216}, MTime: {Sec: 1585284953, NanoSec: 496969216}, CTime: {Sec: 1585319594, NanoSec: 379946655}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 14:34:37.926132 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalk{FID: 9, NewFID: 10, Names: []} D0327 14:34:37.926873 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rwalk{QIDs: []} D0327 14:34:37.927081 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tlopen{FID: 10, Flags: ReadOnly} D0327 14:34:37.928164 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19398870}, IoUnit: 0, File: &{{32}}} D0327 14:34:37.929479 54333 syscalls.go:266] [ 37] Allocating stack with size of 8388608 bytes D0327 14:34:37.930580 54333 task_stop.go:137] [ 36] Leaving internal stop (*kernel.vforkStop)(nil) D0327 14:34:37.972934 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0327 14:34:37.973739 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:37.974056 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 14:34:37.974726 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:37.977711 54333 task_exit.go:221] [ 37] Transitioning from exit state TaskExitNone to TaskExitInitiated D0327 14:34:37.979812 54333 task_exit.go:221] [ 37] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0327 14:34:37.980074 54333 task_signals.go:446] [ 22] Notified of signal 17 D0327 14:34:37.980192 54333 task_block.go:223] [ 22] Interrupt queued D0327 14:34:37.980344 54333 task_block.go:223] [ 22] Interrupt queued D0327 14:34:37.980544 54333 task_signals.go:179] [ 22] Restarting syscall 202 after errno 512: interrupted by signal 17 D0327 14:34:37.980729 54333 task_signals.go:220] [ 22] Signal 17: delivering to handler D0327 14:34:37.980959 54333 task_exit.go:221] [ 37] Transitioning from exit state TaskExitZombie to TaskExitDead D0327 14:34:37.983580 54333 task_block.go:223] [ 38] Interrupt queued D0327 14:34:37.988740 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0327 14:34:38.010222 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] 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: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1585284953, NanoSec: 496969216}, MTime: {Sec: 1585284953, NanoSec: 496969216}, CTime: {Sec: 1585319594, NanoSec: 379946655}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398870}]} D0327 14:34:38.010494 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tclunk{FID: 11} D0327 14:34:38.012904 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rclunk{} D0327 14:34:38.013368 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 14:34:38.014593 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19398870}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1585284953, NanoSec: 496969216}, MTime: {Sec: 1585284953, NanoSec: 496969216}, CTime: {Sec: 1585319594, NanoSec: 379946655}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/27 14:34:38 executed programs: 0 D0327 14:34:38.024456 54333 task_stop.go:118] [ 30] Entering internal stop (*kernel.vforkStop)(nil) D0327 14:34:38.025338 54333 task_block.go:223] [ 39] Interrupt queued D0327 14:34:38.033301 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0327 14:34:38.035489 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] 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: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1585284953, NanoSec: 496969216}, MTime: {Sec: 1585284953, NanoSec: 496969216}, CTime: {Sec: 1585319594, NanoSec: 379946655}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398870}]} D0327 14:34:38.035777 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tclunk{FID: 11} D0327 14:34:38.036377 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rclunk{} D0327 14:34:38.036749 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 14:34:38.037906 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 19398870}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1585284953, NanoSec: 496969216}, MTime: {Sec: 1585284953, NanoSec: 496969216}, CTime: {Sec: 1585319594, NanoSec: 379946655}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 14:34:38.038994 54333 syscalls.go:266] [ 39] Allocating stack with size of 8388608 bytes D0327 14:34:38.039945 54333 task_stop.go:137] [ 30] Leaving internal stop (*kernel.vforkStop)(nil) D0327 14:34:38.050563 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0327 14:34:38.051538 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.051747 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 14:34:38.052682 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.070707 54333 task_block.go:223] [ 40] Interrupt queued D0327 14:34:38.072977 54333 parameters.go:238] Clock(Monotonic): error: -58 ns, adjusted frequency from 2299774820 Hz to 2299774541 Hz D0327 14:34:38.073232 54333 parameters.go:238] Clock(Realtime): error: 242 ns, adjusted frequency from 2299773921 Hz to 2299775080 Hz D0327 14:34:38.073515 54333 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2922972528443672 monotonicBaseRef:85000663372 monotonicFrequency:2299774541 realtimeReady:1 realtimeBaseCycles:2922972529038329 realtimeBaseRef:1585319678073222948 realtimeFrequency:2299775080} D0327 14:34:38.076147 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.076968 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.077243 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.077811 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.078331 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.079098 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.079273 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.079973 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.080554 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.081241 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.081397 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.081927 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.082457 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.083114 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.083378 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.084233 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.084702 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.085272 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.085444 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.086000 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.086575 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.087143 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.087361 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.087999 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.088626 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.089401 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.089681 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.090291 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.090678 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.091425 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.091648 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.092234 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.092965 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.093806 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.094008 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.094688 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.128227 54333 netfilter.go:59] netfilter: convert to binary: current offset: 0 D0327 14:34:38.128426 54333 netfilter.go:59] netfilter: convert to binary: found hook 1 at offset 0 D0327 14:34:38.128598 54333 netfilter.go:59] netfilter: convert to binary: found underflow 1 at offset 0 D0327 14:34:38.128764 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.128910 54333 netfilter.go:59] 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]} D0327 14:34:38.129578 54333 netfilter.go:59] netfilter: convert to binary: current offset: 152 D0327 14:34:38.129706 54333 netfilter.go:59] netfilter: convert to binary: found hook 2 at offset 152 D0327 14:34:38.129834 54333 netfilter.go:59] netfilter: convert to binary: found underflow 2 at offset 152 D0327 14:34:38.129953 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.130128 54333 netfilter.go:59] 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]} D0327 14:34:38.130886 54333 netfilter.go:59] netfilter: convert to binary: current offset: 304 D0327 14:34:38.131042 54333 netfilter.go:59] netfilter: convert to binary: found hook 3 at offset 304 D0327 14:34:38.131132 54333 netfilter.go:59] netfilter: convert to binary: found underflow 3 at offset 304 D0327 14:34:38.131241 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.131377 54333 netfilter.go:59] 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]} D0327 14:34:38.132068 54333 netfilter.go:59] netfilter: convert to binary: current offset: 456 D0327 14:34:38.132215 54333 netfilter.go:59] 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]} D0327 14:34:38.133073 54333 netfilter.go:59] netfilter: convert to binary: finished with an marshalled size of 0 D0327 14:34:38.133215 54333 netfilter.go:59] netfilter: convert to binary: current offset: 0 D0327 14:34:38.133384 54333 netfilter.go:59] netfilter: convert to binary: found hook 0 at offset 0 D0327 14:34:38.133497 54333 netfilter.go:59] netfilter: convert to binary: found underflow 0 at offset 0 D0327 14:34:38.133640 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.133795 54333 netfilter.go:59] 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]} D0327 14:34:38.134689 54333 netfilter.go:59] netfilter: convert to binary: current offset: 152 D0327 14:34:38.134861 54333 netfilter.go:59] netfilter: convert to binary: found hook 1 at offset 152 D0327 14:34:38.135034 54333 netfilter.go:59] netfilter: convert to binary: found underflow 1 at offset 152 D0327 14:34:38.135181 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.135301 54333 netfilter.go:59] 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]} D0327 14:34:38.136068 54333 netfilter.go:59] netfilter: convert to binary: current offset: 304 D0327 14:34:38.136237 54333 netfilter.go:59] netfilter: convert to binary: found hook 3 at offset 304 D0327 14:34:38.136339 54333 netfilter.go:59] netfilter: convert to binary: found underflow 3 at offset 304 D0327 14:34:38.136540 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.136677 54333 netfilter.go:59] 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]} D0327 14:34:38.137451 54333 netfilter.go:59] netfilter: convert to binary: current offset: 456 D0327 14:34:38.137584 54333 netfilter.go:59] netfilter: convert to binary: found hook 4 at offset 456 D0327 14:34:38.137735 54333 netfilter.go:59] netfilter: convert to binary: found underflow 4 at offset 456 D0327 14:34:38.137846 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.137933 54333 netfilter.go:59] 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]} D0327 14:34:38.138526 54333 netfilter.go:59] netfilter: convert to binary: current offset: 608 D0327 14:34:38.138645 54333 netfilter.go:59] 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]} D0327 14:34:38.139441 54333 netfilter.go:59] netfilter: convert to binary: finished with an marshalled size of 0 D0327 14:34:38.139640 54333 netfilter.go:59] netfilter: convert to binary: current offset: 0 D0327 14:34:38.139698 54333 netfilter.go:59] netfilter: convert to binary: found hook 0 at offset 0 D0327 14:34:38.139797 54333 netfilter.go:59] netfilter: convert to binary: found underflow 0 at offset 0 D0327 14:34:38.139879 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.139981 54333 netfilter.go:59] 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]} D0327 14:34:38.140546 54333 netfilter.go:59] netfilter: convert to binary: current offset: 152 D0327 14:34:38.140667 54333 netfilter.go:59] netfilter: convert to binary: found hook 3 at offset 152 D0327 14:34:38.140758 54333 netfilter.go:59] netfilter: convert to binary: found underflow 3 at offset 152 D0327 14:34:38.140842 54333 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 14:34:38.140943 54333 netfilter.go:59] 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]} D0327 14:34:38.141763 54333 netfilter.go:59] netfilter: convert to binary: current offset: 304 D0327 14:34:38.141936 54333 netfilter.go:59] 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]} D0327 14:34:38.142813 54333 netfilter.go:59] netfilter: convert to binary: finished with an marshalled size of 0 D0327 14:34:38.335648 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.336415 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.336608 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.337416 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.337843 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.338601 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.338788 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.339438 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.339714 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.340352 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.340563 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.341135 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.341426 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.342022 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.342160 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.342704 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.343082 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.343779 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.343911 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.344482 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.344805 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.345384 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.345808 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.346609 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.347025 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.347620 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.347793 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.348167 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.348426 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.348992 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.349214 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.349670 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.349955 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.350479 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.350643 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.351437 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.351781 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 14:34:38.352502 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 2} D0327 14:34:38.352787 54333 transport_flipcall.go:127] send [channel @0xc0003983c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 14:34:38.353534 54333 transport_flipcall.go:234] recv [channel @0xc0003983c0] Rlerror{Error: 95} D0327 14:34:38.374081 54333 task_block.go:223] [ 41] Interrupt queued panic: interface conversion: context.Context is kernel.taskAsyncContext, not *kernel.Task goroutine 253 [running]: gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).Write(0xc0009f0000, 0x1494640, 0xc0001c4050, 0xc0001f8c60, 0x148e240, 0xc0004f9000, 0x0, 0x1, 0x0, 0x9, ...) pkg/sentry/socket/netstack/netstack.go:538 +0x5d0 gvisor.dev/gvisor/pkg/sentry/fs.(*File).Pwritev(0xc0001f8c60, 0x1494640, 0xc0001c4050, 0x148e240, 0xc0004f9000, 0x0, 0x1, 0x0, 0x9, 0x0, ...) pkg/sentry/fs/file.go:374 +0x270 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.performCallback(0xc00075b500, 0xc0001f8c60, 0x20000000, 0xc0003a40c0, 0x148e240, 0xc0004f9000, 0x0, 0x1, 0x0, 0x9, ...) pkg/sentry/syscalls/linux/sys_aio.go:265 +0x507 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.submitCallback.func1() pkg/sentry/syscalls/linux/sys_aio.go:351 +0xdc gvisor.dev/gvisor/pkg/sentry/fs.Async.func1(0xc0006b2000) pkg/sentry/fs/fs.go:86 +0x6b created by gvisor.dev/gvisor/pkg/sentry/fs.Async pkg/sentry/fs/fs.go:84 +0x5d goroutine 1 [semacquire, 1 minutes]: sync.runtime_Semacquire(0xc000156084) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc000156084) GOROOT/src/sync/waitgroup.go:130 +0xd4 gvisor.dev/gvisor/pkg/sentry/kernel.(*Kernel).WaitExited(...) pkg/sentry/kernel/kernel.go:1161 gvisor.dev/gvisor/runsc/boot.(*Loader).WaitExit(0xc00016a160, 0x0, 0x0) runsc/boot/loader.go:905 +0x73 gvisor.dev/gvisor/runsc/cmd.(*Boot).Execute(0xc0002a02d0, 0x1484580, 0xc00021c000, 0xc0002ba300, 0xc0002dcd60, 0x2, 0x2, 0x0) runsc/cmd/boot.go:260 +0xaf1 github.com/google/subcommands.(*Commander).Execute(0xc000232000, 0x1484580, 0xc00021c000, 0xc0002dcd60, 0x2, 0x2, 0x0) external/com_github_google_subcommands/subcommands.go:200 +0x51d github.com/google/subcommands.Execute(...) external/com_github_google_subcommands/subcommands.go:481 main.main() runsc/main.go:327 +0x2c21 goroutine 19 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0x13225f8, 0xc000202720, 0xc000202780) pkg/sentry/platform/ptrace/subprocess.go:175 +0x22a created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:159 +0x217 goroutine 20 [sync.Cond.Wait]: runtime.goparkunlock(...) GOROOT/src/runtime/proc.go:310 sync.runtime_notifyListWait(0xc00038a948, 0x2) GOROOT/src/runtime/sema.go:513 +0xf8 sync.(*Cond).Wait(0xc00038a938) GOROOT/src/sync/cond.go:56 +0x8e gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).findReclaimable(0xc00038a500, 0x0, 0x0, 0x0) pkg/sentry/pgalloc/pgalloc.go:1090 +0xbe gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).runReclaim(0xc00038a500) pkg/sentry/pgalloc/pgalloc.go:1019 +0x7b created by gvisor.dev/gvisor/pkg/sentry/pgalloc.NewMemoryFile pkg/sentry/pgalloc/pgalloc.go:330 +0x2f4 goroutine 21 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater.func1(0xc0002ba840, 0xc000346460) pkg/sentry/kernel/timekeeper.go:216 +0x204 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater pkg/sentry/kernel/timekeeper.go:184 +0xfe goroutine 22 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e060, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e060, 0xc0003e0701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0700) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 23 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e080, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e080, 0xc0003e0701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0770) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 24 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e0a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e0a0, 0xc0003e0801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e07e0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 25 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e0c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e0c0, 0xc0003e0801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0850) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 26 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124000, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124000, 0xc0003e0801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e08c0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 27 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124020, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124020, 0xc0003e0901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0930) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 28 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e0e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e0e0, 0xc0003e0901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e09a0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 29 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124040, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124040, 0xc0003e0a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0a10) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 30 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e100, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e100, 0xc0003e0a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0a80) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 31 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e120, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e120, 0xc0003e0b01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0af0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 32 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124060, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124060, 0xc0003e0b01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0b60) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 33 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124080, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124080, 0xc0003e0c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0bd0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 34 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e140, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e140, 0xc0003e0c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0c40) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 35 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e160, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e160, 0xc0003e0c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0cb0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 36 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0001240a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0001240a0, 0xc0003e0d01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0d20) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 37 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e180, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e180, 0xc0003e0d01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0d90) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 38 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0001240c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0001240c0, 0xc0003e0e01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0e00) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 39 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0001240e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0001240e0, 0xc0003e0e01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0e70) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 40 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124100, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124100, 0xc0003e0f01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0ee0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 41 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124120, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124120, 0xc0003e0f01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0f50) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 42 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e1a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e1a0, 0xc0003e0f01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e0fc0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 43 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124140, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124140, 0xc0003e1001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e1030) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 44 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124160, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124160, 0xc0003e1001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e10a0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 45 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e1c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e1c0, 0xc0003e1101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e1110) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 46 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000124180, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000124180, 0xc0003e1101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e1180) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 47 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e1e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e1e0, 0xc0003e1201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e11f0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 48 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0001241a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0001241a0, 0xc0003e1201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e1260) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 49 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e200, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e200, 0xc0003e1301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e12d0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 50 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f23a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f23a0, 0xc0003e1301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003e1340) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 66 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e220, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e220, 0xc000126001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126000) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 67 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f23c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f23c0, 0xc000126001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126070) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 68 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f23e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f23e0, 0xc000126101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001260e0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 69 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e240, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e240, 0xc000126101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126150) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 70 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2400, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2400, 0xc000126101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001261c0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 71 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e260, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e260, 0xc000126201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126230) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 72 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2420, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2420, 0xc000126201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001262a0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 73 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e280, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e280, 0xc000126301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126310) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 74 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000480000, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000480000, 0xc000126301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126380) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 75 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e2a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e2a0, 0xc000126401, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001263f0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 76 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2440, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2440, 0xc000126401, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126460) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 77 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2460, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2460, 0xc000126501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001264d0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 78 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e2c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e2c0, 0xc000126501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126540) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 79 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e2e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e2e0, 0xc000126501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001265b0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 80 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e300, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e300, 0xc000126601, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126620) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 81 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e320, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e320, 0xc000126601, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126690) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 82 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2480, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2480, 0xc000126701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126700) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 83 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e340, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e340, 0xc000126701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126770) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 84 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e360, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e360, 0xc000126801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001267e0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 85 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e380, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e380, 0xc000126801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126850) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 86 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f24a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f24a0, 0xc000126801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001268c0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 87 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f24c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f24c0, 0xc000126901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126930) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 88 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e3a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e3a0, 0xc000126901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0001269a0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 89 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e3c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e3c0, 0xc000126a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126a10) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 90 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e3e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e3e0, 0xc000126a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126a80) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 91 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f24e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f24e0, 0xc000126b01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126af0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 92 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e400, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e400, 0xc000126b01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126b60) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 93 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2500, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2500, 0xc000126c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126bd0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 94 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2520, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2520, 0xc000126c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126c40) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 95 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e420, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e420, 0xc000126c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126cb0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 96 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e440, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e440, 0xc000126d01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126d20) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 97 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2540, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2540, 0xc000126d01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126d90) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 98 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e460, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e460, 0xc000126e01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126e00) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 99 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003f2560, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003f2560, 0xc000126e01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126e70) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 100 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00000e480, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e480, 0xc000126f01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000126ee0) pkg/tcpip/transport/tcp/dispatcher.go:106 +0x2db created by gvisor.dev/gvisor/pkg/tcpip/transport/tcp.newProcessor pkg/tcpip/transport/tcp/dispatcher.go:80 +0xdf goroutine 307 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0000fc000, 0xc0008022a0, 0x0, 0xc0006b74f0, 0xc00052a028) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0000fc000, 0xc0008022a0, 0x1485b00, 0x0, 0xc420151948, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0000fc000, 0x0, 0xc0000fc001, 0xc420151948, 0x20470100, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0000fc000, 0xc420151948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0006b77e8, 0x44006f, 0xc000053000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0000fc000, 0xca, 0xc420151948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0000fc000, 0xca, 0xc420151948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc0000fc8af) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0000fc000, 0xca, 0xc420151948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0006b7cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0000fc000, 0x2, 0xc0002a6d00) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0000fc000, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0000fc000, 0x22) pkg/sentry/kernel/task_run.go:92 +0x321 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:315 +0x19e goroutine 102 [syscall]: syscall.Syscall6(0x10f, 0xc000560e50, 0x2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:41 +0x5 gvisor.dev/gvisor/pkg/unet.(*Socket).wait(0xc00011ebd0, 0xffffffffffffff00, 0x0, 0x0) pkg/unet/unet_unsafe.go:55 +0xe4 gvisor.dev/gvisor/pkg/unet.(*ServerSocket).Accept(0xc000142038, 0x0, 0x0, 0x0) pkg/unet/unet.go:539 +0x18c gvisor.dev/gvisor/pkg/control/server.(*Server).serve(0xc000124860) pkg/control/server/server.go:99 +0x50 gvisor.dev/gvisor/pkg/control/server.(*Server).StartServing.func1(0xc000124860) pkg/control/server/server.go:87 +0x39 created by gvisor.dev/gvisor/pkg/control/server.(*Server).StartServing pkg/control/server/server.go:86 +0xc9 goroutine 127 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00015e120) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x248 goroutine 135 [syscall, 1 minutes]: syscall.Syscall6(0x119, 0x14, 0xc0000f0ae0, 0x64, 0xffffffffffffffff, 0x0, 0x0, 0xc00023c8e0, 0xc00023c868, 0xc000416000) src/syscall/asm_linux_amd64.s:41 +0x5 gvisor.dev/gvisor/pkg/fdnotifier.epollWait(0x14, 0xc0000f0ae0, 0x64, 0x64, 0xffffffffffffffff, 0x2, 0x2, 0x2) pkg/fdnotifier/poll_unsafe.go:77 +0x83 gvisor.dev/gvisor/pkg/fdnotifier.(*notifier).waitAndNotify(0xc0002dcaa0, 0x0, 0x1025400) pkg/fdnotifier/fdnotifier.go:149 +0x9e created by gvisor.dev/gvisor/pkg/fdnotifier.newNotifier pkg/fdnotifier/fdnotifier.go:64 +0x114 goroutine 136 [syscall, 1 minutes]: syscall.Syscall6(0x10f, 0xc00021c0c0, 0x1, 0x0, 0x0, 0x0, 0x0, 0x11701e0, 0xc00021c0b8, 0x1170c60) src/syscall/asm_linux_amd64.s:41 +0x5 golang.org/x/sys/unix.ppoll(0xc00021c0c0, 0x1, 0x0, 0x0, 0xc00021c0c0, 0x10, 0x100000000000001) external/org_golang_x_sys/unix/zsyscall_linux.go:87 +0xa2 golang.org/x/sys/unix.Ppoll(0xc00021c0c0, 0x1, 0x1, 0x0, 0x0, 0x0, 0x0, 0x44faf0) external/org_golang_x_sys/unix/syscall_linux.go:142 +0xda gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor.func1.1(0xef440a, 0x8, 0x1, 0x0) runsc/boot/loader.go:710 +0x60 gvisor.dev/gvisor/runsc/specutils.RetryEintr(0xc000565f80, 0x8, 0x0, 0x0, 0x1) runsc/specutils/specutils.go:475 +0x39 gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor.func1(0x7ffd42636f9c, 0x25, 0xc00038eb48, 0x1, 0x1, 0xc00016a160) runsc/boot/loader.go:708 +0x25a created by gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor runsc/boot/loader.go:699 +0x7f goroutine 137 [syscall, 1 minutes]: syscall.Syscall6(0x10f, 0xc000491f08, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:41 +0x5 golang.org/x/sys/unix.ppoll(0xc000491f08, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0) external/org_golang_x_sys/unix/zsyscall_linux.go:87 +0xa2 golang.org/x/sys/unix.Ppoll(0xc000491f08, 0x1, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0) external/org_golang_x_sys/unix/syscall_linux.go:142 +0xda gvisor.dev/gvisor/pkg/p9.(*Client).watch(0xc0002da100, 0xc000354ba0) pkg/p9/client.go:252 +0xe0 created by gvisor.dev/gvisor/pkg/p9.NewClient pkg/p9/client.go:232 +0x75e goroutine 138 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0002a0480) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x248 goroutine 139 [syscall, 1 minutes]: os/signal.signal_recv(0x46b501) GOROOT/src/runtime/sigqueue.go:147 +0x9c os/signal.loop() GOROOT/src/os/signal/signal_unix.go:23 +0x30 created by os/signal.Notify.func1 GOROOT/src/os/signal/signal.go:127 +0x7c goroutine 163 [select, 1 minutes]: reflect.rselect(0xc000426480, 0x22, 0x22, 0xc000426480, 0x1be07d8) GOROOT/src/runtime/select.go:544 +0x3bd reflect.Select(0xc0004ac000, 0x22, 0x49, 0x20, 0x21, 0xc0004ac000, 0x20, 0x49) GOROOT/src/reflect/value.go:2229 +0x1f0 gvisor.dev/gvisor/pkg/sentry/sighandling.handleSignals(0xc0005c0000, 0x21, 0x40, 0xc0003dc590, 0xc000203320, 0xc000203380) pkg/sentry/sighandling/sighandling.go:44 +0x4a1 created by gvisor.dev/gvisor/pkg/sentry/sighandling.StartSignalForwarding pkg/sentry/sighandling/sighandling.go:96 +0x288 goroutine 164 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).loop(0xc000536000) pkg/sentry/watchdog/watchdog.go:232 +0x149 created by gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).Start pkg/sentry/watchdog/watchdog.go:191 +0x32d goroutine 165 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001a8090) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x248 goroutine 166 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0002fc000, 0xc0002032c0, 0x0, 0x46d22c, 0xc00031f700) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0002fc000, 0xc0002032c0, 0x1485b00, 0x0, 0x5489888, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0002fc000, 0x0, 0xc0002fc001, 0x5489888, 0x72b700, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0002fc000, 0x5489888, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00072b7e8, 0x44006f, 0xc00003f000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0002fc000, 0xca, 0x5489888, 0x0, 0x0, 0x0, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0002fc000, 0xca, 0x5489888, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc0002fc8af) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0002fc000, 0xca, 0x5489888, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00072bcd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0002fc000, 0x2, 0xc00057e000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0002fc000, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0002fc000, 0x1) pkg/sentry/kernel/task_run.go:92 +0x321 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:315 +0x19e goroutine 167 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001a8120) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x248 goroutine 168 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc00015c110, 0xc0005d0120, 0xc0005d0180) pkg/sentry/platform/ptrace/subprocess.go:175 +0x22a created by gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:159 +0x217 goroutine 155 [semacquire, 1 minutes]: sync.runtime_Semacquire(0xc0005aceb8) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc0005aceb0) GOROOT/src/sync/waitgroup.go:130 +0xd4 gvisor.dev/gvisor/pkg/sentry/kernel.(*ThreadGroup).WaitExited(...) pkg/sentry/kernel/task_run.go:372 gvisor.dev/gvisor/runsc/boot.(*Loader).wait(0xc00016a160, 0xc0005ac800, 0x25) runsc/boot/loader.go:893 +0x43 gvisor.dev/gvisor/runsc/boot.(*Loader).waitContainer(0xc00016a160, 0xc0004ca0f0, 0x25, 0xc0005864a8, 0x0, 0xc000518588) runsc/boot/loader.go:848 +0x1af gvisor.dev/gvisor/runsc/boot.(*containerManager).Wait(0xc000124880, 0xc00044c4b0, 0xc0005864a8, 0x0, 0x0) runsc/boot/controller.go:430 +0xb9 reflect.Value.call(0xc000518540, 0xc000142190, 0x13, 0x12ea670, 0x4, 0xc000325e60, 0x3, 0x3, 0x149d601, 0xc0005864a8, ...) GOROOT/src/reflect/value.go:460 +0x967 reflect.Value.Call(0xc000518540, 0xc000142190, 0x13, 0xc000325e60, 0x3, 0x3, 0x0, 0xc000124880, 0x16) GOROOT/src/reflect/value.go:321 +0xd4 gvisor.dev/gvisor/pkg/urpc.(*Server).handleOne(0xc00011ec60, 0xc000572150, 0x0, 0x0) pkg/urpc/urpc.go:325 +0x688 gvisor.dev/gvisor/pkg/urpc.(*Server).handleRegistered(0xc00011ec60, 0xc000572150, 0x0, 0x0) pkg/urpc/urpc.go:420 +0x43 gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc00011ec60, 0xc000572150) pkg/urpc/urpc.go:440 +0x90 created by gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling pkg/urpc/urpc.go:438 +0x6f goroutine 156 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc00043c000, 0xc0001221e0, 0xc0004cc0c0, 0x0, 0x0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc00043c000, 0xc0001221e0, 0xc00043c901, 0x21d0bcff97, 0xc000320498, 0x10) pkg/sentry/kernel/task_block.go:80 +0xda gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00043c000, 0xc0001221e0, 0x1485b01, 0xdf8475800, 0x5488ad0, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:42 +0x11d gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00043c000, 0xdf8475800, 0x0, 0x5488ad0, 0x0, 0xffffffff, 0xaeb693, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00043c000, 0x5488ad0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc0004037e8, 0x44006f, 0xc00003f000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00043c000, 0xca, 0x5488ad0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00043c000, 0xca, 0x5488ad0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x4078ff, 0xc00043c8af) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00043c000, 0xca, 0x5488ad0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc000403cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00043c000, 0x2, 0xc00057e000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00043c000, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc00043c000, 0x2) pkg/sentry/kernel/task_run.go:92 +0x321 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:315 +0x19e goroutine 169 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0005f2000, 0xc0005d03c0, 0x0, 0x46d22c, 0xc000320ea0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0005f2000, 0xc0005d03c0, 0x1485b00, 0x0, 0x54a7c00, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0005f2000, 0x0, 0xc0005f2001, 0x54a7c00, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0005f2000, 0x54a7c00, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003b17e8, 0x44006f, 0xc000049000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0005f2000, 0xca, 0x54a7c00, 0x0, 0x0, 0x0, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0005f2000, 0xca, 0x54a7c00, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc0005f28af) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0005f2000, 0xca, 0x54a7c00, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003b1cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0005f2000, 0x2, 0xc00057e000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0005f2000, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0005f2000, 0x3) pkg/sentry/kernel/task_run.go:92 +0x321 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:315 +0x19e goroutine 157 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0003d2120) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x248 goroutine 170 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0005f2a80, 0xc0005d0600, 0xc0005d0660, 0x0, 0x0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc0005f2a80, 0xc0005d0600, 0xc0005f3301, 0x1413d7fd79, 0xc000321218, 0x10) pkg/sentry/kernel/task_block.go:80 +0xda gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0005f2a80, 0xc0005d0600, 0x1485b01, 0x3b6dd477, 0x548cd00, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:42 +0x11d gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0005f2a80, 0x3b6dd477, 0x0, 0x548cd00, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0005f2a80, 0x548cd00, 0x0, 0x0, 0xc4204ea6d8, 0x0, 0x0, 0xc0003ad7e8, 0x44006f, 0xc000044000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0005f2a80, 0xca, 0x548cd00, 0x0, 0x0, 0xc4204ea6d8, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0005f2a80, 0xca, 0x548cd00, 0x0, 0x0, 0xc4204ea6d8, 0x0, 0x0, 0x4078ff, 0xc0005f332f) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0005f2a80, 0xca, 0x548cd00, 0x0, 0x0, 0xc4204ea6d8, 0x0, 0x0, 0xc0003adcd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0005f2a80, 0x2, 0xc00057e000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0005f2a80, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0005f2a80, 0x4) pkg/sentry/kernel/task_run.go:92 +0x321 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:315 +0x19e goroutine 171 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0001a81b0) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x248 goroutine 172 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0005f3500, 0xc0005d09c0, 0x0, 0x0, 0xc00031f280) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0005f3500, 0xc0005d09c0, 0x1485b00, 0x0, 0xc4200fa148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0005f3500, 0x0, 0xc0005f3501, 0xc4200fa148, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0005f3500, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0006077e8, 0x44006f, 0xc00003f000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0005f3500, 0xca, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0005f3500, 0xca, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc0005f3daf) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0005f3500, 0xca, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000607cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0005f3500, 0x2, 0xc00057e000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0005f3500, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0005f3500, 0x5) pkg/sentry/kernel/task_run.go:92 +0x321 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:315 +0x19e goroutine 178 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00060e000) pkg/sentry/kernel/time/time.go:515 +0x149 created by gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:494 +0x248 goroutine 194 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc00043ca80, 0xc0002025a0, 0x0, 0x46d22c, 0xc00031fbe0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00043ca80, 0xc0002025a0, 0x1485b00, 0x0, 0xc42015e148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00043ca80, 0x0, 0xc00043ca01, 0xc42015e148, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00043ca80, 0xc42015e148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003277e8, 0x44006f, 0xc000046800, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00043ca80, 0xca, 0xc42015e148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00043ca80, 0xca, 0xc42015e148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc00043d32f) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00043ca80, 0xca, 0xc42015e148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000327cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00043ca80, 0x2, 0xc00057e000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00043ca80, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc00043ca80, 0x6) pkg/sentry/kernel/task_run.go:92 +0x321 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:315 +0x19e W0327 14:34:38.584214 54326 sandbox.go:750] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-0" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D0327 14:34:38.584672 54326 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.584858 54326 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.584946 54326 sandbox.go:1126] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-0" by destroying sandbox D0327 14:34:38.585084 54326 sandbox.go:796] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.585222 54326 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 54332 I0327 14:34:38.686627 54326 main.go:329] Exiting with status: 512 VM DIAGNOSIS: I0327 14:34:38.425230 55160 main.go:305] *************************** I0327 14:34:38.425438 55160 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-0] I0327 14:34:38.425741 55160 main.go:307] Version release-20200219.0-252-g76a7ace751bf I0327 14:34:38.425878 55160 main.go:308] PID: 55160 I0327 14:34:38.425964 55160 main.go:309] UID: 0, GID: 0 I0327 14:34:38.426087 55160 main.go:310] Configuration: I0327 14:34:38.426178 55160 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0327 14:34:38.426292 55160 main.go:312] Platform: ptrace I0327 14:34:38.426361 55160 main.go:313] FileAccess: shared, overlay: false I0327 14:34:38.426486 55160 main.go:314] Network: sandbox, logging: false I0327 14:34:38.426606 55160 main.go:315] Strace: false, max size: 1024, syscalls: [] I0327 14:34:38.426713 55160 main.go:316] *************************** W0327 14:34:38.426824 55160 main.go:321] Block the TERM signal. This is only safe in tests! D0327 14:34:38.427046 55160 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.434817 55160 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0327 14:34:38.434993 55160 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.435090 55160 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.435648 55160 urpc.go:534] urpc: successfully marshalled 117 bytes. I0327 14:34:38.584120 55160 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 54333 I0327 14:34:38.584298 55160 debug.go:137] Retrieving sandbox stacks D0327 14:34:38.584416 55160 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.584663 55160 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0327 14:34:38.584877 55160 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 54333: connection refused retrieving stacks: connecting to control server at PID 54333: connection refused W0327 14:34:38.585300 55160 main.go:338] Failure to execute command, err: 1 Error collecting stacks: failed to run ["/syzkaller/managers/ptrace-proxy-sandbox-race/current/image" "-root" "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "-watchdog-action=panic" "-network=none" "-debug" "-alsologtostderr" "-platform=ptrace" "-file-access=shared" "-network=sandbox" "-TESTONLY-unsafe-nonroot" "debug" "-stacks" "--ps" "ci-gvisor-ptrace-proxy-sandbox-race-0"]: exit status 128 I0327 14:34:38.425230 55160 main.go:305] *************************** I0327 14:34:38.425438 55160 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-0] I0327 14:34:38.425741 55160 main.go:307] Version release-20200219.0-252-g76a7ace751bf I0327 14:34:38.425878 55160 main.go:308] PID: 55160 I0327 14:34:38.425964 55160 main.go:309] UID: 0, GID: 0 I0327 14:34:38.426087 55160 main.go:310] Configuration: I0327 14:34:38.426178 55160 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0327 14:34:38.426292 55160 main.go:312] Platform: ptrace I0327 14:34:38.426361 55160 main.go:313] FileAccess: shared, overlay: false I0327 14:34:38.426486 55160 main.go:314] Network: sandbox, logging: false I0327 14:34:38.426606 55160 main.go:315] Strace: false, max size: 1024, syscalls: [] I0327 14:34:38.426713 55160 main.go:316] *************************** W0327 14:34:38.426824 55160 main.go:321] Block the TERM signal. This is only safe in tests! D0327 14:34:38.427046 55160 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.434817 55160 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-0": signal 0 D0327 14:34:38.434993 55160 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.435090 55160 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.435648 55160 urpc.go:534] urpc: successfully marshalled 117 bytes. I0327 14:34:38.584120 55160 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0", PID: 54333 I0327 14:34:38.584298 55160 debug.go:137] Retrieving sandbox stacks D0327 14:34:38.584416 55160 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" D0327 14:34:38.584663 55160 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-0" W0327 14:34:38.584877 55160 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 54333: connection refused retrieving stacks: connecting to control server at PID 54333: connection refused W0327 14:34:38.585300 55160 main.go:338] Failure to execute command, err: 1 [303047.533539] [] ? vmx_vcpu_run+0x337/0x4f0 [kvm_intel] [303047.533540] [] ? kvm_arch_vcpu_ioctl_run+0x6df/0x16d0 [kvm] [303047.533541] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303047.533542] [] ? recalc_sigpending+0x17/0x50 [303047.533542] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533543] [] ? signal_setup_done+0x67/0xb0 [303047.533544] [] ? __seccomp_filter+0x74/0x270 [303047.533545] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533545] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533546] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533547] [] ? SyS_ioctl+0x74/0x80 [303047.533548] [] ? do_syscall_64+0x8d/0x100 [303047.533549] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533552] Code: c00 c81 ce2 cff c07 c00 c80 c81 cfa c12 c03 c00 c80 c74 c29 c25 c00 c07 c00 c80 c3d c00 c02 c00 c80 c74 c06 c48 c83 cc4 c08 c5b cc3 c48 c89 cdf ce8 c14 c21 cf1 cff ccd c02 c<48> c83 cc4 c08 c48 c89 cdf c5b ce9 c15 c21 cf1 cff c48 c89 c04 c24 ce8 c4c cd7 cff c [303047.533556] NMI backtrace for cpu 20 [303047.533557] CPU: 20 PID: 60724 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533631] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533633] task: ffff9fb43a72f040 task.stack: ffffba1951568000 [303047.533634] RIP: 0010:[] c [] native_queued_spin_lock_slowpath+0x21/0x1a0 [303047.533635] RSP: 0018:ffffba195156bbf0 EFLAGS: 00000202 [303047.533636] RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000000903e6e [303047.533636] RDX: 0000000000000001 RSI: 0000000000000001 RDI: ffff9fc0ba150000 [303047.533637] RBP: ffff9fbe319dae80 R08: 0000000000000007 R09: 8000000000000000 [303047.533638] R10: 00000003ffffffff R11: 0400000000000000 R12: 0000000100433020 [303047.533639] R13: 0000000000100433 R14: 0000000000000000 R15: 0000000000000000 [303047.533640] FS: 000000c0005cc090(0000) GS:ffff9fca86b00000(0000) knlGS:0000000000000000 [303047.533641] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533642] CR2: 00007ffd5d5e8a00 CR3: 00000013f95f6000 CR4: 0000000000162670 [303047.533643] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533643] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533644] Stack: [303047.533645] ffffffffa141e2fdc ffffffffc0908f1bc ffffba195156bc27c ffffffffc09cf00cc [303047.533646] 0000000100000000c 000000000001d0d8c 0001ffffc09cf018c 0000000100000000c [303047.533646] 0000000000903e6ec c70dcebbea6e6addc ffff9fbe319dae80c 0000000100433020c [303047.533647] Call Trace: [303047.533648] [] ? _raw_spin_lock+0x1d/0x20 [303047.533649] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303047.533650] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533651] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303047.533652] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303047.533653] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533654] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533655] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533656] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533657] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533657] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533658] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533659] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533660] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303047.533660] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303047.533661] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303047.533662] [] ? recalc_sigpending+0x17/0x50 [303047.533663] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533664] [] ? signal_setup_done+0x67/0xb0 [303047.533665] [] ? __seccomp_filter+0x74/0x270 [303047.533665] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533667] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533668] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533668] [] ? SyS_ioctl+0x74/0x80 [303047.533669] [] ? do_syscall_64+0x8d/0x100 [303047.533670] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533673] Code: cfe cff cff c0f c1f c80 c00 c00 c00 c00 c0f c1f c44 c00 c00 c0f c1f c44 c00 c00 cba c01 c00 c00 c00 c8b c07 c85 cc0 c75 c0a cf0 c0f cb1 c17 c85 cc0 c75 cf2 cf3 cc3 cf3 c90 c cec c81 cfe c00 c01 c00 c00 c0f c84 c1c c01 c00 c00 c40 c30 cf6 c85 cf6 c75 c42 c [303047.533675] NMI backtrace for cpu 23 [303047.533677] CPU: 23 PID: 10374 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533678] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533678] task: ffff9fca75cd9000 task.stack: ffffba196a380000 [303047.533679] RIP: 0010:[] c [] clear_page_c_e+0x9/0x10 [303047.533681] RSP: 0000:ffffba196a383c80 EFLAGS: 00000246 [303047.533683] RAX: 0000000000000000 RBX: 0000000000000001 RCX: 0000000000000000 [303047.533684] RDX: 017fffc000040001 RSI: fffffa17e433e000 RDI: ffff9fc5ccf81000 [303047.533685] RBP: ffff9fca7551ce18 R08: dead0000000000ff R09: 0000000000000040 [303047.533685] R10: 0000000000000000 R11: 0000000000000001 R12: ffff9fca75cd9000 [303047.533686] R13: 0000000000000000 R14: 0000000000000000 R15: fffffa17e433e000 [303047.533687] FS: 000000c001b21210(0000) GS:ffff9fca86bc0000(0000) knlGS:0000000000000000 [303047.533688] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533689] CR2: 00007f42920b4000 CR3: 0000001081fd8000 CR4: 0000000000162670 [303047.533690] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533691] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533691] Stack: [303047.533693] ffffffffa0fa3587c 0000000000014fecc ffff9fca7551cf90c 024200ca86bd89e8c [303047.533694] 0000000014fec000c ffff9fb43ee19800c ffff9fca7551cdb0c 0000000000014fecc [303047.533695] ffff9fca78b0e480c 0000000000000001c ffff9fca75cd9000c ffffba196a383d74c [303047.533696] Call Trace: [303047.533697] [] ? shmem_getpage_gfp+0x657/0xcc0 [303047.533698] [] ? __switch_to_asm+0x35/0x70 [303047.533699] [] ? __switch_to_asm+0x41/0x70 [303047.533700] [] ? shmem_fault+0x74/0x1d0 [303047.533701] [] ? __switch_to_asm+0x35/0x70 [303047.533702] [] ? __switch_to_asm+0x41/0x70 [303047.533703] [] ? __switch_to_asm+0x35/0x70 [303047.533704] [] ? __switch_to_asm+0x41/0x70 [303047.533705] [] ? __switch_to_asm+0x35/0x70 [303047.533706] [] ? __do_fault+0xa9/0x1c0 [303047.533707] [] ? handle_mm_fault+0xae8/0x1350 [303047.533708] [] ? __do_page_fault+0x255/0x4f0 [303047.533709] [] ? page_fault+0x28/0x30 [303047.533711] Code: c89 c47 c18 c48 c89 c47 c20 c48 c89 c47 c28 c48 c89 c47 c30 c48 c89 c47 c38 c48 c8d c7f c40 c75 cd9 c90 cc3 c0f c1f c80 c00 c00 c00 c00 cb9 c00 c10 c00 c00 c31 cc0 cf3 caa c c90 c90 c90 c90 c90 c90 c0f c1f c44 c00 c00 c48 c85 cff c0f c84 cb5 c00 c00 c00 c [303047.533714] NMI backtrace for cpu 33 [303047.533715] CPU: 33 PID: 4112 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533717] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533719] task: ffff9fb7e0834040 task.stack: ffffba196af24000 [303047.533719] RIP: 0010:[] c [] native_queued_spin_lock_slowpath+0x21/0x1a0 [303047.533720] RSP: 0018:ffffba196af27bf0 EFLAGS: 00000202 [303047.533721] RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000000a3a872 [303047.533721] RDX: 0000000000000001 RSI: 0000000000000001 RDI: ffff9fc0ba150000 [303047.533722] RBP: ffff9fc907299c40 R08: 0000000000000007 R09: 8000000000000000 [303047.533722] R10: 00000003ffffffff R11: 0400000000000000 R12: 00003fa3e15fe6a0 [303047.533723] R13: 00000003fa3e15fe R14: 0000000000000000 R15: 0000000000000000 [303047.533724] FS: 000000c00037cb10(0000) GS:ffff9fca86e40000(0000) knlGS:ffff80c0002d2480 [303047.533724] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533725] CR2: 00007ffd5d5e8a00 CR3: 00000013f95f6000 CR4: 0000000000162670 [303047.533726] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533726] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533727] Stack: [303047.533727] ffffffffa141e2fdc ffffffffc0908f1bc ffffba196af27c27c ffffffffc09cf00cc [303047.533728] 0000000100000000c 000000000001d0d8c 0001ffffc09cf018c 0000000100000000c [303047.533728] 0000000000a3a872c e4f642a033477f70c ffff9fc907299c40c 00003fa3e15fe6a0c [303047.533729] Call Trace: [303047.533729] [] ? _raw_spin_lock+0x1d/0x20 [303047.533730] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303047.533730] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533731] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303047.533731] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303047.533732] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533732] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533733] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533734] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533735] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533735] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533736] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533737] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533737] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303047.533738] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303047.533739] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303047.533740] [] ? recalc_sigpending+0x17/0x50 [303047.533740] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533741] [] ? signal_setup_done+0x67/0xb0 [303047.533742] [] ? __seccomp_filter+0x74/0x270 [303047.533742] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533743] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533743] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533744] [] ? SyS_ioctl+0x74/0x80 [303047.533745] [] ? do_syscall_64+0x8d/0x100 [303047.533745] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533747] Code: cfe cff cff c0f c1f c80 c00 c00 c00 c00 c0f c1f c44 c00 c00 c0f c1f c44 c00 c00 cba c01 c00 c00 c00 c8b c07 c85 cc0 c75 c0a cf0 c0f cb1 c17 c85 cc0 c75 cf2 cf3 cc3 cf3 c90 c cec c81 cfe c00 c01 c00 c00 c0f c84 c1c c01 c00 c00 c40 c30 cf6 c85 cf6 c75 c42 c [303047.533750] NMI backtrace for cpu 28 [303047.533751] CPU: 28 PID: 10045 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533752] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533753] task: ffff9fc026e32100 task.stack: ffffba197c418000 [303047.533753] RIP: 0010:[] c [] smp_call_function_single+0xd3/0x130 [303047.533754] RSP: 0018:ffffba197c41bc30 EFLAGS: 00000202 [303047.533755] RAX: 0000000000000000 RBX: 0000000000000034 RCX: ffffda193fb03a80 [303047.533755] RDX: 0000000000000001 RSI: ffffba197c41bc40 RDI: ffffba197c41bc40 [303047.533756] RBP: ffffffffc09d4a50 R08: 0000000000000002 R09: ffff9fb28475d400 [303047.533757] R10: 000000000000002e R11: ffff9fafbdc47c38 R12: 0000000000000034 [303047.533758] R13: ffff9fb5bc489440 R14: ffff9fafbdc47c00 R15: 000000000000001c [303047.533758] FS: 000000c001db8090(0000) GS:ffff9fca86d00000(0000) knlGS:0000000000000000 [303047.533759] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533760] CR2: 000060022b4f0000 CR3: 0000001649bc2000 CR4: 0000000000162670 [303047.533761] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533761] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533762] Stack: [303047.533763] 0000000000000246c ffff9fca870d8980c ffffda193fb03a80c ffffffffc09d4a50c [303047.533764] ffff9fb5bc48d9d8c 0000000000000003c ef6d2721131b6b37c 000000000000001cc [303047.533765] ffffba197c41bd90c ffffffffc09d3e9fc ffffffffa0e2f8f5c ffff9fc4cbb360c0c [303047.533765] Call Trace: [303047.533766] [] ? update_debugctlmsr+0x20/0x20 [kvm_intel] [303047.533767] [] ? vmx_vcpu_load+0x9f/0x360 [kvm_intel] [303047.533768] [] ? sched_clock+0x5/0x10 [303047.533768] [] ? check_preempt_curr+0x4e/0x90 [303047.533769] [] ? ttwu_do_wakeup+0x14/0xe0 [303047.533770] [] ? try_to_wake_up+0x54/0x3c0 [303047.533770] [] ? wake_up_q+0x3f/0x70 [303047.533771] [] ? kvm_arch_vcpu_load+0x46/0x290 [kvm] [303047.533772] [] ? recalc_sigpending+0x17/0x50 [303047.533772] [] ? vcpu_load+0x3c/0x50 [kvm] [303047.533773] [] ? kvm_vcpu_ioctl+0x77/0x5e0 [kvm] [303047.533774] [] ? signal_setup_done+0x67/0xb0 [303047.533775] [] ? __seccomp_filter+0x74/0x270 [303047.533775] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533776] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533776] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533777] [] ? SyS_ioctl+0x74/0x80 [303047.533778] [] ? do_syscall_64+0x8d/0x100 [303047.533778] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533780] Code: c25 c28 c00 c00 c00 c75 c73 c48 c83 cc4 c38 c5b c5d cc3 c48 c8d c74 c24 c10 c48 c89 cd1 c89 cdf c48 c89 cea ce8 c28 cfe cff cff c8b c54 c24 c28 c83 ce2 c01 c74 c0b cf3 c90 c<8b> c54 c24 c28 c83 ce2 c01 c75 cf5 ceb cc1 c8b c05 cc4 c85 cdb c00 c85 cc0 c75 c83 c [303047.533783] NMI backtrace for cpu 51 [303047.533784] CPU: 51 PID: 6922 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533785] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533786] task: ffff9fb698b23040 task.stack: ffffba19730fc000 [303047.533787] RIP: 0010:[] c [] vmx_complete_atomic_exit.constprop.93+0x5e/0x80 [kvm_intel] [303047.533788] RSP: 0018:ffffba19730ffce0 EFLAGS: 00000046 [303047.533788] RAX: 0000000080000200 RBX: ffff9fc5a3b607c0 RCX: ffff9fc5a3b607c0 [303047.533789] RDX: 0000000080000202 RSI: 0000000000000000 RDI: ffff9fc5a3b607c0 [303047.533790] RBP: ffff9fc5a3b607c0 R08: 0000000000000000 R09: 0000000000000000 [303047.533791] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 [303047.533792] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 [303047.533792] FS: 000000c0003cd910(0000) GS:ffff9fca872c0000(0000) knlGS:ffff80c0004f0d80 [303047.533793] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533794] CR2: 00007ffe84775a00 CR3: 00000013dbf30000 CR4: 0000000000162670 [303047.533794] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533795] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533797] Stack: [303047.533797] ffffffffc09cf018c 0000000000000000c ffffffffc09e0ba7c ffff9fc5a3b607c0c [303047.533798] 0000000000000000c ffff9fc5a3b607c0c ffffba19730ffde8c 0000000000000000c [303047.533798] 0000000000231788c 0000000000000000c 0000000000000000c ffffffffc08fa25fc [303047.533799] Call Trace: [303047.533800] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533801] [] ? vmx_vcpu_run+0x337/0x4f0 [kvm_intel] [303047.533801] [] ? kvm_arch_vcpu_ioctl_run+0x6df/0x16d0 [kvm] [303047.533802] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303047.533803] [] ? recalc_sigpending+0x17/0x50 [303047.533804] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533805] [] ? signal_setup_done+0x67/0xb0 [303047.533806] [] ? __seccomp_filter+0x74/0x270 [303047.533807] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533808] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533808] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533809] [] ? SyS_ioctl+0x74/0x80 [303047.533810] [] ? do_syscall_64+0x8d/0x100 [303047.533811] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533812] Code: c00 c81 ce2 cff c07 c00 c80 c81 cfa c12 c03 c00 c80 c74 c29 c25 c00 c07 c00 c80 c3d c00 c02 c00 c80 c74 c06 c48 c83 cc4 c08 c5b cc3 c48 c89 cdf ce8 c14 c21 cf1 cff ccd c02 c<48> c83 cc4 c08 c48 c89 cdf c5b ce9 c15 c21 cf1 cff c48 c89 c04 c24 ce8 c4c cd7 cff c [303047.533814] NMI backtrace for cpu 26 [303047.533815] CPU: 26 PID: 9278 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533816] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533817] task: ffff9fae6ead2140 task.stack: ffffba1979804000 [303047.533818] RIP: 0010:[] c [] vmx_complete_atomic_exit.constprop.93+0x5e/0x80 [kvm_intel] [303047.533819] RSP: 0018:ffffba1979807ce0 EFLAGS: 00000046 [303047.533820] RAX: 0000000080000200 RBX: ffff9fad133d8540 RCX: ffff9fad133d8540 [303047.533821] RDX: 0000000080000202 RSI: 0000000000000000 RDI: ffff9fad133d8540 [303047.533822] RBP: ffff9fad133d8540 R08: 0000000000000000 R09: 0000000000000000 [303047.533822] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 [303047.533823] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 [303047.533824] FS: 000000c002f1a090(0000) GS:ffff9fca86c80000(0000) knlGS:ffff80c0004f0480 [303047.533825] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533826] CR2: 00007ffe84775a00 CR3: 00000013dbf30000 CR4: 0000000000162670 [303047.533826] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533827] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533828] Stack: [303047.533829] ffffffffc09cf018c 0000000000000000c ffffffffc09e0ba7c ffff9fad133d8540c [303047.533830] 0000000000000000c ffff9fad133d8540c ffffba1979807de8c 0000000000000000c [303047.533830] 0000000000231788c 0000000000000000c 0000000000000000c ffffffffc08fa25fc [303047.533831] Call Trace: [303047.533832] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533832] [] ? vmx_vcpu_run+0x337/0x4f0 [kvm_intel] [303047.533833] [] ? kvm_arch_vcpu_ioctl_run+0x6df/0x16d0 [kvm] [303047.533834] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303047.533835] [] ? recalc_sigpending+0x17/0x50 [303047.533836] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533836] [] ? signal_setup_done+0x67/0xb0 [303047.533837] [] ? __seccomp_filter+0x74/0x270 [303047.533838] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533838] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533839] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533840] [] ? SyS_ioctl+0x74/0x80 [303047.533840] [] ? do_syscall_64+0x8d/0x100 [303047.533841] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533843] Code: c00 c81 ce2 cff c07 c00 c80 c81 cfa c12 c03 c00 c80 c74 c29 c25 c00 c07 c00 c80 c3d c00 c02 c00 c80 c74 c06 c48 c83 cc4 c08 c5b cc3 c48 c89 cdf ce8 c14 c21 cf1 cff ccd c02 c<48> c83 cc4 c08 c48 c89 cdf c5b ce9 c15 c21 cf1 cff c48 c89 c04 c24 ce8 c4c cd7 cff c [303047.533846] NMI backtrace for cpu 49 [303047.533847] CPU: 49 PID: 4001 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533849] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533850] task: ffff9faf4ab9b040 task.stack: ffffba196a93c000 [303047.533851] RIP: 0010:[] c [] vmx_complete_atomic_exit.constprop.93+0x5e/0x80 [kvm_intel] [303047.533851] RSP: 0018:ffffba196a93fce0 EFLAGS: 00000046 [303047.533852] RAX: 0000000080000200 RBX: ffff9fb9ab7b8ac0 RCX: ffff9fb9ab7b8ac0 [303047.533853] RDX: 0000000080000202 RSI: 0000000000000000 RDI: ffff9fb9ab7b8ac0 [303047.533853] RBP: ffff9fb9ab7b8ac0 R08: 0000000000000000 R09: 0000000000000000 [303047.533854] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 [303047.533855] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 [303047.533855] FS: 000000c000880790(0000) GS:ffff9fca87240000(0000) knlGS:ffff80c0006a2000 [303047.533856] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533856] CR2: 00007ffd5d5e8a00 CR3: 00000013f95f6000 CR4: 0000000000162670 [303047.533857] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533858] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533858] Stack: [303047.533859] ffffffffc09cf018c 0000000000000000c ffffffffc09e0ba7c ffff9fb9ab7b8ac0c [303047.533860] 0000000000000000c ffff9fb9ab7b8ac0c ffffba196a93fde8c 0000000000000000c [303047.533861] 0000000000231788c 0000000000000000c 0000000000000000c ffffffffc08fa25fc [303047.533861] Call Trace: [303047.533862] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533863] [] ? vmx_vcpu_run+0x337/0x4f0 [kvm_intel] [303047.533863] [] ? kvm_arch_vcpu_ioctl_run+0x6df/0x16d0 [kvm] [303047.533864] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303047.533865] [] ? recalc_sigpending+0x17/0x50 [303047.533865] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533866] [] ? signal_setup_done+0x67/0xb0 [303047.533867] [] ? __seccomp_filter+0x74/0x270 [303047.533868] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533868] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533869] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533870] [] ? SyS_ioctl+0x74/0x80 [303047.533870] [] ? do_syscall_64+0x8d/0x100 [303047.533871] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533872] Code: c00 c81 ce2 cff c07 c00 c80 c81 cfa c12 c03 c00 c80 c74 c29 c25 c00 c07 c00 c80 c3d c00 c02 c00 c80 c74 c06 c48 c83 cc4 c08 c5b cc3 c48 c89 cdf ce8 c14 c21 cf1 cff ccd c02 c<48> c83 cc4 c08 c48 c89 cdf c5b ce9 c15 c21 cf1 cff c48 c89 c04 c24 ce8 c4c cd7 cff c [303047.533874] NMI backtrace for cpu 29 [303047.533875] CPU: 29 PID: 9810 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533876] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533877] task: ffff9fc8a0432140 task.stack: ffffba197bcfc000 [303047.533878] RIP: 0010:[] c [] native_queued_spin_lock_slowpath+0x21/0x1a0 [303047.533879] RSP: 0018:ffffba197bcffbf0 EFLAGS: 00000202 [303047.533880] RAX: 0000000000000001 RBX: 0000000000000000 RCX: 000000000170f58b [303047.533881] RDX: 0000000000000001 RSI: 0000000000000001 RDI: ffff9fc0ba150000 [303047.533882] RBP: ffff9fbd309d16c0 R08: 0000000000000007 R09: 8000000000000000 [303047.533882] R10: 00000003ffffffff R11: 0400000000000000 R12: 00000001007ccc20 [303047.533883] R13: 00000000001007cc R14: 0000000000000000 R15: 0000000000000000 [303047.533883] FS: 000000c0020a0090(0000) GS:ffff9fca86d40000(0000) knlGS:0000000000000000 [303047.533884] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533885] CR2: 00007ffd5d5e8a00 CR3: 00000013f95f6000 CR4: 0000000000162670 [303047.533885] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533887] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533887] Stack: [303047.533888] ffffffffa141e2fdc ffffffffc0908f1bc ffffba197bcffc27c ffffffffc09cf00cc [303047.533889] 0000000100000000c 000000000001d0d8c 0001ffffc09cf018c 0000000100000000c [303047.533889] 000000000170f58bc 7d756755335ad6bfc ffff9fbd309d16c0c 00000001007ccc20c [303047.533890] Call Trace: [303047.533891] [] ? _raw_spin_lock+0x1d/0x20 [303047.533891] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303047.533892] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533893] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303047.533894] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303047.533894] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533895] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533895] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533896] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533897] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533898] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533899] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533900] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533900] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303047.533901] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303047.533902] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303047.533903] [] ? recalc_sigpending+0x17/0x50 [303047.533903] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533904] [] ? signal_setup_done+0x67/0xb0 [303047.533904] [] ? __seccomp_filter+0x74/0x270 [303047.533905] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533906] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533906] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533907] [] ? SyS_ioctl+0x74/0x80 [303047.533908] [] ? do_syscall_64+0x8d/0x100 [303047.533909] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533910] Code: cfe cff cff c0f c1f c80 c00 c00 c00 c00 c0f c1f c44 c00 c00 c0f c1f c44 c00 c00 cba c01 c00 c00 c00 c8b c07 c85 cc0 c75 c0a cf0 c0f cb1 c17 c85 cc0 c75 cf2 cf3 cc3 cf3 c90 c cec c81 cfe c00 c01 c00 c00 c0f c84 c1c c01 c00 c00 c40 c30 cf6 c85 cf6 c75 c42 c [303047.533915] NMI backtrace for cpu 42 [303047.533916] CPU: 42 PID: 4000 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533917] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533917] task: ffff9faf3bf48000 task.stack: ffffba196a92c000 [303047.533918] RIP: 0010:[] c [] native_queued_spin_lock_slowpath+0x21/0x1a0 [303047.533919] RSP: 0018:ffffba196a92fbf0 EFLAGS: 00000202 [303047.533920] RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000001abba2d [303047.533921] RDX: 0000000000000001 RSI: 0000000000000001 RDI: ffff9fc0ba150000 [303047.533922] RBP: ffff9fb24e339e80 R08: 0000000000000007 R09: 8000000000000000 [303047.533923] R10: 00000003ffffffff R11: 0400000000000000 R12: 000000010086bec0 [303047.533924] R13: 000000000010086b R14: 0000000000000000 R15: 0000000000000000 [303047.533925] FS: 000000c000800e90(0000) GS:ffff9fca87080000(0000) knlGS:0000000000000000 [303047.533926] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533927] CR2: 00007ffd5d5e8a00 CR3: 00000013f95f6000 CR4: 0000000000162670 [303047.533927] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533928] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533928] Stack: [303047.533929] ffffffffa141e2fdc ffffffffc0908f1bc ffffba196a92fc27c ffffffffc09cf00cc [303047.533930] 0000000100000000c 000000000001d0d8c 0001ffffc09cf018c 0000000100000000c [303047.533931] 0000000001abba2dc ddd113bbedc918bcc ffff9fb24e339e80c 000000010086bec0c [303047.533931] Call Trace: [303047.533932] [] ? _raw_spin_lock+0x1d/0x20 [303047.533933] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303047.533934] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303047.533935] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303047.533936] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303047.533937] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303047.533937] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303047.533938] [] ? recalc_sigpending+0x17/0x50 [303047.533939] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533940] [] ? signal_setup_done+0x67/0xb0 [303047.533941] [] ? __seccomp_filter+0x74/0x270 [303047.533943] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533943] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533944] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533945] [] ? SyS_ioctl+0x74/0x80 [303047.533946] [] ? do_syscall_64+0x8d/0x100 [303047.533946] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533949] Code: cfe cff cff c0f c1f c80 c00 c00 c00 c00 c0f c1f c44 c00 c00 c0f c1f c44 c00 c00 cba c01 c00 c00 c00 c8b c07 c85 cc0 c75 c0a cf0 c0f cb1 c17 c85 cc0 c75 cf2 cf3 cc3 cf3 c90 c cec c81 cfe c00 c01 c00 c00 c0f c84 c1c c01 c00 c00 c40 c30 cf6 c85 cf6 c75 c42 c [303047.533957] NMI backtrace for cpu 58 [303047.533958] CPU: 58 PID: 64191 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533959] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533960] task: ffff9fb2509ae040 task.stack: ffffba195d080000 [303047.533961] RIP: 0010:[] c [] vmx_complete_atomic_exit.constprop.93+0x5e/0x80 [kvm_intel] [303047.533962] RSP: 0018:ffffba195d083ce0 EFLAGS: 00000046 [303047.533963] RAX: 0000000080000200 RBX: ffff9fc9bedf0800 RCX: ffff9fc9bedf0800 [303047.533964] RDX: 0000000080000202 RSI: 0000000000000000 RDI: ffff9fc9bedf0800 [303047.533965] RBP: ffff9fc9bedf0800 R08: 0000000000000000 R09: 0000000000000000 [303047.533966] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 [303047.533967] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 [303047.533967] FS: 000000c0006cc090(0000) GS:ffff9fca87480000(0000) knlGS:ffff80c00047f680 [303047.533968] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533968] CR2: 00007fffbb7dea00 CR3: 0000001649bc2000 CR4: 0000000000162670 [303047.533969] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533970] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533971] Stack: [303047.533972] ffffffffc09cf018c 0000000000000000c ffffffffc09e0ba7c ffff9fc9bedf0800c [303047.533973] 0000000000000000c ffff9fc9bedf0800c ffffba195d083de8c 0000000000000000c [303047.533973] 0000000000231788c 0000000000000000c 0000000000000000c ffffffffc08fa25fc [303047.533974] Call Trace: [303047.533976] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533976] [] ? vmx_vcpu_run+0x337/0x4f0 [kvm_intel] [303047.533977] [] ? kvm_arch_vcpu_ioctl_run+0x6df/0x16d0 [kvm] [303047.533977] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303047.533978] [] ? recalc_sigpending+0x17/0x50 [303047.533979] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533980] [] ? signal_setup_done+0x67/0xb0 [303047.533981] [] ? __seccomp_filter+0x74/0x270 [303047.533982] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533982] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533984] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533984] [] ? SyS_ioctl+0x74/0x80 [303047.533985] [] ? do_syscall_64+0x8d/0x100 [303047.533986] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533987] Code: c00 c81 ce2 cff c07 c00 c80 c81 cfa c12 c03 c00 c80 c74 c29 c25 c00 c07 c00 c80 c3d c00 c02 c00 c80 c74 c06 c48 c83 cc4 c08 c5b cc3 c48 c89 cdf ce8 c14 c21 cf1 cff ccd c02 c<48> c83 cc4 c08 c48 c89 cdf c5b ce9 c15 c21 cf1 cff c48 c89 c04 c24 ce8 c4c cd7 cff c [303047.533992] NMI backtrace for cpu 46 [303047.533993] CPU: 46 PID: 10145 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533994] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533995] task: ffff9fc3f2274080 task.stack: ffffba1952d70000 [303047.533996] RIP: 0010:[] c [] vmx_complete_atomic_exit.constprop.93+0x5e/0x80 [kvm_intel] [303047.533997] RSP: 0018:ffffba1952d73ce0 EFLAGS: 00000046 [303047.533998] RAX: 0000000080000200 RBX: ffff9fadcf710cc0 RCX: ffff9fadcf710cc0 [303047.533999] RDX: 0000000080000202 RSI: 0000000000000000 RDI: ffff9fadcf710cc0 [303047.534000] RBP: ffff9fadcf710cc0 R08: 0000000000000000 R09: 0000000000000000 [303047.534001] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 [303047.534001] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 [303047.534002] FS: 000000c001b17c90(0000) GS:ffff9fca87180000(0000) knlGS:ffff80c00021e900 [303047.534003] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.534004] CR2: 00007ffe84775a00 CR3: 00000013dbf30000 CR4: 0000000000162670 [303047.534004] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.534005] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.534005] Stack: [303047.534006] ffffffffc09cf018c 0000000000000000c ffffffffc09e0ba7c ffff9fadcf710cc0c [303047.534007] 0000000000000000c ffff9fadcf710cc0c ffffba1952d73de8c 0000000000000000c [303047.534007] 0000000000231788c 0000000000000000c 0000000000000000c ffffffffc08fa25fc [303047.534008] Call Trace: [303047.534009] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.534010] [] ? vmx_vcpu_run+0x337/0x4f0 [kvm_intel] [303047.534010] [] ? kvm_arch_vcpu_ioctl_run+0x6df/0x16d0 [kvm] [303047.534011] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303047.534012] [] ? recalc_sigpending+0x17/0x50 [303047.534012] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.534013] [] ? signal_setup_done+0x67/0xb0 [303047.534013] [] ? __seccomp_filter+0x74/0x270 [303047.534014] [] ? do_vfs_ioctl+0xa2/0x620 [303047.534015] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.534016] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.534016] [] ? SyS_ioctl+0x74/0x80 [303047.534017] [] ? do_syscall_64+0x8d/0x100 [303047.534018] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.534020] Code: c00 c81 ce2 cff c07 c00 c80 c81 cfa c12 c03 c00 c80 c74 c29 c25 c00 c07 c00 c80 c3d c00 c02 c00 c80 c74 c06 c48 c83 cc4 c08 c5b cc3 c48 c89 cdf ce8 c14 c21 cf1 cff ccd c02 c<48> c83 cc4 c08 c48 c89 cdf c5b ce9 c15 c21 cf1 cff c48 c89 c04 c24 ce8 c4c cd7 cff c [303047.542935] systemd[1]: systemd-journald.service: Main process exited, code=killed, status=6/ABRT [303047.544776] systemd[1]: systemd-journald.service: Unit entered failed state. [303047.548351] systemd[1]: systemd-journald.service: Failed with result 'watchdog'. [303047.550595] systemd[1]: systemd-journald.service: Service has no hold-off time, scheduling restart. [303047.554705] systemd[1]: Stopped Flush Journal to Persistent Storage. [303047.554755] systemd[1]: Stopping Flush Journal to Persistent Storage... [303047.554766] systemd[1]: Stopped Journal Service. [303047.573768] systemd[1]: Starting Journal Service... [303047.791946] audit_log_start: 275 callbacks suppressed [303047.791947] audit: audit_backlog=321 > audit_backlog_limit=320 [303047.791949] audit: audit_lost=901 audit_rate_limit=0 audit_backlog_limit=320 [303047.791950] audit: backlog limit exceeded [303047.792864] audit: audit_backlog=321 > audit_backlog_limit=320 [303047.792866] audit: audit_lost=902 audit_rate_limit=0 audit_backlog_limit=320 [303047.792867] audit: backlog limit exceeded [303047.800036] audit: audit_backlog=321 > audit_backlog_limit=320 [303047.800038] audit: audit_lost=903 audit_rate_limit=0 audit_backlog_limit=320 [303047.800039] audit: backlog limit exceeded [303047.817300] audit: audit_backlog=321 > audit_backlog_limit=320 [303052.874187] audit_log_start: 1887 callbacks suppressed [303052.874188] audit: audit_backlog=321 > audit_backlog_limit=320 [303052.874190] audit: audit_lost=1534 audit_rate_limit=0 audit_backlog_limit=320 [303052.874191] audit: backlog limit exceeded [303052.967274] audit: audit_backlog=321 > audit_backlog_limit=320 [303052.967276] audit: audit_lost=1535 audit_rate_limit=0 audit_backlog_limit=320 [303052.967277] audit: backlog limit exceeded [303052.994119] audit: audit_backlog=321 > audit_backlog_limit=320 [303052.994121] audit: audit_lost=1536 audit_rate_limit=0 audit_backlog_limit=320 [303052.994122] audit: backlog limit exceeded [303053.147465] audit: audit_backlog=321 > audit_backlog_limit=320 [303057.910200] audit_log_start: 155 callbacks suppressed [303057.910201] audit: audit_backlog=321 > audit_backlog_limit=320 [303057.910203] audit: audit_lost=1589 audit_rate_limit=0 audit_backlog_limit=320 [303057.910204] audit: backlog limit exceeded [303058.035847] audit: audit_backlog=321 > audit_backlog_limit=320 [303058.035849] audit: audit_lost=1590 audit_rate_limit=0 audit_backlog_limit=320 [303058.035850] audit: backlog limit exceeded [303058.076769] audit: audit_backlog=321 > audit_backlog_limit=320 [303058.076771] audit: audit_lost=1591 audit_rate_limit=0 audit_backlog_limit=320 [303058.076771] audit: backlog limit exceeded [303058.125273] audit: audit_backlog=321 > audit_backlog_limit=320 [303063.635533] audit_log_start: 191 callbacks suppressed [303063.635535] audit: audit_backlog=321 > audit_backlog_limit=320 [303063.635537] audit: audit_lost=1656 audit_rate_limit=0 audit_backlog_limit=320 [303063.635538] audit: backlog limit exceeded [303063.702445] audit: audit_backlog=321 > audit_backlog_limit=320 [303063.702448] audit: audit_lost=1657 audit_rate_limit=0 audit_backlog_limit=320 [303063.702449] audit: backlog limit exceeded [303063.746271] audit: audit_backlog=321 > audit_backlog_limit=320 [303063.746273] audit: audit_lost=1658 audit_rate_limit=0 audit_backlog_limit=320 [303063.746274] audit: backlog limit exceeded [303063.778447] audit: audit_backlog=321 > audit_backlog_limit=320 [303067.769304] 9-...: (36756 ticks this GP) idle=059/140000000000001/0 softirq=33473469/33473469 fqs=18232 [303067.779342] (t=43700 jiffies g=12067405 c=12067404 q=201178) [303067.785553] Task dump for CPU 9: [303067.789007] exe R running task 0 4036 60665 0x00000988 [303067.796933] ffffffffa1b19a00 ffffffffa0ea953b 0000000000000009 ffffffffa1b19a00 [303067.805121] ffffffffa0f830ad ffff9fca868596c0 ffffffffa1a4fd80 0000000000000000 [303067.813384] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002ac8466 [303067.821922] Call Trace: [303067.824595] [303067.826751] [] ? sched_show_task+0xcb/0x130 [303067.832839] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [303067.839153] [] ? rcu_check_callbacks+0x75a/0x8b0 [303067.845642] [] ? tick_sched_do_timer+0x30/0x30 [303067.851958] [] ? update_process_times+0x28/0x50 [303067.859134] [] ? tick_sched_handle.isra.12+0x20/0x50 [303067.866749] [] ? tick_sched_timer+0x38/0x70 [303067.872838] [] ? __hrtimer_run_queues+0xde/0x250 [303067.879577] [] ? hrtimer_interrupt+0x9c/0x1a0 [303067.885810] [] ? smp_apic_timer_interrupt+0x47/0x60 [303067.892556] [] ? apic_timer_interrupt+0x9e/0xb0 [303067.898952] [303067.901100] [] ? native_queued_spin_lock_slowpath+0x1f/0x1a0 [303067.908655] [] ? _raw_spin_lock+0x1d/0x20 [303067.914576] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303067.921184] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303067.928143] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303067.935144] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303067.942437] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303067.949899] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303067.956744] [] ? recalc_sigpending+0x17/0x50 [303067.962917] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303067.969498] [] ? signal_setup_done+0x67/0xb0 [303067.975655] [] ? __seccomp_filter+0x74/0x270 [303067.981803] [] ? do_vfs_ioctl+0xa2/0x620 [303067.987602] [] ? __audit_syscall_entry+0xaa/0xf0 [303067.994187] [] ? syscall_trace_enter+0x1ae/0x2c0 [303068.000679] [] ? SyS_ioctl+0x74/0x80 [303068.006687] [] ? do_syscall_64+0x8d/0x100 [303068.012596] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303068.019874] Task dump for CPU 59: [303068.023406] exe R running task 0 60695 60665 0x00000188 [303068.031112] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [303068.039396] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [303068.047898] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [303068.056079] Call Trace: [303068.058740] [] ? vfs_fallocate+0x15a/0x220 [303068.064792] [] ? SyS_fallocate+0x43/0x80 [303068.070588] [] ? do_syscall_64+0x8d/0x100 [303068.076461] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303068.123390] systemd-journald[11697]: File /var/log/journal/01955a2033483b89dfbbcdc06e3dd1a5/system.journal corrupted or uncleanly shut down, renaming and replacing. [303068.729307] systemd[1]: Started Journal Service. [303068.736639] audit_log_start: 371 callbacks suppressed [303068.736641] audit: audit_backlog=321 > audit_backlog_limit=320 [303068.740082] audit: audit_backlog=321 > audit_backlog_limit=320 [303068.740084] audit: audit_lost=1783 audit_rate_limit=0 audit_backlog_limit=320 [303068.740085] audit: backlog limit exceeded [303068.766810] audit: audit_lost=1784 audit_rate_limit=0 audit_backlog_limit=320 [303068.774187] audit: backlog limit exceeded [303068.810936] audit: audit_backlog=321 > audit_backlog_limit=320 [303068.818235] audit: audit_lost=1785 audit_rate_limit=0 audit_backlog_limit=320 [303068.825600] audit: backlog limit exceeded [303068.832523] audit: audit_backlog=321 > audit_backlog_limit=320 [304020.737296] exe invoked oom-killer: gfp_mask=0x24280ca(GFP_HIGHUSER_MOVABLE|__GFP_ZERO), nodemask=0, order=0, oom_score_adj=0 [304020.748841] exe cpuset=/ mems_allowed=0 [304020.753135] CPU: 49 PID: 45699 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [304020.763199] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [304020.772613] 0000000000000000 ffffffffa1136404 ffffba19523abcf0 ffff9fc5a42f7040 [304020.780702] ffffffffa1009690 0000000000000000 0000000000000000 0000000c7138a080 [304020.788852] ffff9fbd4cd82140 ffffffffa0f8d207 0000004200000000 ffffffffa10acee0 [304020.796937] Call Trace: [304020.799595] [] ? dump_stack+0x5c/0x78 [304020.805274] [] ? dump_header+0x78/0x1fd [304020.811160] [] ? get_page_from_freelist+0x3f7/0xb20 [304020.817888] [] ? cap_inode_killpriv+0x20/0x20 [304020.824090] [] ? oom_kill_process+0x22a/0x3f0 [304020.830329] [] ? out_of_memory+0x111/0x470 [304020.836286] [] ? __alloc_pages_slowpath+0xa1f/0xb30 [304020.843014] [] ? __alloc_pages_nodemask+0x201/0x260 [304020.849830] [] ? alloc_pages_vma+0xaa/0x280 [304020.855862] [] ? handle_mm_fault+0x10ff/0x1350 [304020.862154] [] ? __do_page_fault+0x255/0x4f0 [304020.868306] [] ? page_fault+0x28/0x30 [304020.873828] Mem-Info: [304020.876318] active_anon:30416056 inactive_anon:97561 isolated_anon:0 active_file:451 inactive_file:198 isolated_file:0 unevictable:0 dirty:65 writeback:0 unstable:0 slab_reclaimable:9255 slab_unreclaimable:38015 mapped:91018 shmem:97883 pagetables:116308 bounce:0 free:138597 free_pcp:0 free_cma:0 [304020.911280] Node 0 active_anon:121664224kB inactive_anon:390244kB active_file:1700kB inactive_file:1120kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:364252kB dirty:260kB writeback:0kB shmem:391532kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 180224kB writeback_tmp:0kB unstable:0kB pages_scanned:54711 all_unreclaimable? no [304020.941789] Node 0 DMA free:15908kB min:8kB low:20kB high:32kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [304020.971610] lowmem_reserve[]: 0 2974 120837 120837 120837 [304020.978076] Node 0 DMA32 free:473104kB min:1660kB low:4704kB high:7748kB active_anon:2561884kB inactive_anon:21824kB active_file:0kB inactive_file:36kB unevictable:0kB writepending:0kB present:3129320kB managed:3063752kB mlocked:0kB slab_reclaimable:72kB slab_unreclaimable:676kB kernel_stack:340kB pagetables:5172kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [304021.010945] lowmem_reserve[]: 0 0 117862 117862 117862 [304021.017050] Node 0 Normal free:65528kB min:65908kB low:186596kB high:307284kB active_anon:119102344kB inactive_anon:368420kB active_file:1708kB inactive_file:0kB unevictable:0kB writepending:0kB present:122683392kB managed:120696220kB mlocked:0kB slab_reclaimable:36792kB slab_unreclaimable:151384kB kernel_stack:58620kB pagetables:460060kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [304021.051765] lowmem_reserve[]: 0 0 0 0 0 [304021.056556] Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15908kB [304021.072877] Node 0 DMA32: 641*4kB (UMEH) 441*8kB (UME) 254*16kB (UME) 97*32kB (UME) 118*64kB (UME) 137*128kB (UE) 57*256kB (UME) 17*512kB (UE) 2*1024kB (UE) 2*2048kB (UH) 99*4096kB (UM) = 473292kB [304021.093587] Node 0 Normal: 16645*4kB (UMEH) 52*8kB (UMH) 17*16kB (MH) 8*32kB (H) 8*64kB (H) 2*128kB (H) 1*256kB (H) 1*512kB (H) 0*1024kB 0*2048kB 0*4096kB = 69060kB [304021.111224] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [304021.120184] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [304021.128843] 98992 total pagecache pages [304021.132898] 0 pages in swap cache [304021.136424] Swap cache stats: add 0, delete 0, find 0/0 [304021.141886] Free swap = 0kB [304021.144979] Total swap = 0kB [304021.148070] 31457176 pages RAM [304021.151333] 0 pages HighMem/MovableOnly [304021.155376] 513206 pages reserved [304021.158918] 0 pages hwpoisoned [304021.162179] [ pid ] uid tgid total_vm rss nr_ptes nr_pmds swapents oom_score_adj name [304021.170978] [ 960] 0 960 11548 333 23 3 0 -1000 systemd-udevd [304021.180514] [ 1125] 0 1125 13686 112 26 3 0 -1000 auditd [304021.189422] [ 1137] 0 1137 21093 63 12 3 0 0 audispd [304021.198425] [ 1151] 109 1151 11282 112 28 3 0 -900 dbus-daemon [304021.208844] [ 1155] 0 1155 1051 21 8 3 0 0 acpid [304021.217679] [ 1157] 0 1157 7409 61 19 3 0 0 cron [304021.227399] [ 1180] 0 1180 32156 3293 63 5 0 0 syz-ci [304021.236441] [ 1660] 0 1660 5119 274 12 3 0 0 dhclient [304021.245523] [ 1707] 0 1707 90842 12385 116 4 0 0 puppet [304021.254859] [ 1714] 0 1714 3575 34 12 3 0 0 agetty [304021.263772] [ 1716] 0 1716 3631 33 12 3 0 0 agetty [304021.272682] [ 1743] 106 1743 24474 132 23 4 0 0 ntpd [304021.281424] [ 1746] 0 1746 268282 42669 442 4 0 0 ruby [304021.290160] [ 2124] 0 2124 17077 3645 39 4 0 0 google_network_ [304021.300021] [ 2195] 0 2195 17239 3748 40 3 0 -999 google_accounts [304021.309702] [ 2354] 0 2354 17072 3582 39 3 0 0 google_clock_sk [304021.319381] [ 2355] 0 2355 17489 187 37 4 0 -1000 sshd [304021.328449] [42133] 0 42133 93324 39694 170 5 0 0 syz-manager [304021.337785] [45406] 0 45406 97717 42735 163 5 0 0 syz-manager [304021.347124] [25482] 0 25482 103813 52158 156 5 0 0 syz-manager [304021.359587] [40452] 0 40452 140417 66988 195 5 0 0 syz-manager [304021.368929] [64967] 0 64967 126458 48607 163 5 0 0 syz-manager [304021.378260] [ 1597] 0 1597 113749 76498 222 5 0 0 syz-manager [304021.387678] [47853] 0 47853 9495 121 22 3 0 0 systemd-logind [304021.397306] [44758] 0 44758 62528 490 31 3 0 0 rsyslogd [304021.406751] [60762] 0 60762 179882 720 20 5 0 0 image [304021.415673] [11697] 0 11697 70803 135 133 3 0 0 systemd-journal [304021.425471] [32945] 0 32945 180167 710 21 4 0 0 image [304021.434301] [33147] 0 33147 180234 704 21 5 0 0 image [304021.443116] [33152] 0 33152 180170 699 21 4 0 0 image [304021.451935] [33155] 0 33155 179882 654 21 4 0 0 image [304021.460757] [33173] 0 33173 181326 713 25 5 0 0 exe [304021.474025] [33178] 0 33178 211248 4708 55 6 0 0 exe [304021.482674] [33179] 0 33179 181326 707 25 5 0 0 exe [304021.491329] [33180] 0 33180 181550 822 26 4 0 0 exe [304021.499979] [33181] 0 33181 211440 4900 56 5 0 0 exe [304021.508619] [33189] 0 33189 39022468 19143149 69766 141 0 0 exe [304021.517261] [33255] 0 33255 1 1 1 1 0 0 exe [304021.526724] [33266] 0 33266 1 1 1 1 0 0 exe [304021.535410] [33273] 0 33273 1 1 1 1 0 0 exe [304021.544073] [33322] 0 33322 23617 4135 52 6 0 0 exe [304021.552729] [33326] 0 33326 24061 3428 52 6 0 0 exe [304021.561421] [33335] 0 33335 23230 3955 52 6 0 0 exe [304021.570125] [34894] 0 34894 179818 653 21 5 0 0 image [304021.579099] [34900] 0 34900 181326 732 25 4 0 0 exe [304021.587751] [34901] 0 34901 211312 4731 56 6 0 0 exe [304021.596569] [34910] 0 34910 179818 626 21 4 0 0 image [304021.606515] [34918] 0 34918 29353 3368 30 6 0 0 exe [304021.618892] [34932] 0 34932 1 1 1 1 0 0 exe [304021.627546] [34949] 0 34949 23415 4139 52 6 0 0 exe [304021.640104] [34967] 0 34967 4691 1 5 4 0 0 exe [304021.649030] [34983] 0 34983 1 1 1 1 0 0 exe [304021.657813] [34992] 0 34992 4835 1 5 4 0 0 exe [304021.666491] [34993] 0 34993 708 1 5 4 0 0 exe [304021.675152] [34999] 0 34999 1 1 1 1 0 0 exe [304021.688601] [35008] 0 35008 595 1 5 4 0 0 exe [304021.697249] [35018] 0 35018 1 1 1 1 0 0 exe [304021.706682] [35026] 0 35026 6681 1 9 5 0 0 exe [304021.715321] [35047] 0 35047 741 1 5 4 0 0 exe [304021.723963] [35215] 0 35215 6604 1 9 5 0 0 exe [304021.732623] [35226] 0 35226 6648 1 9 5 0 0 exe [304021.742751] [38417] 0 38417 4804 1 5 4 0 0 exe [304021.751392] [38944] 0 38944 331784 3917 65 10 0 0 image [304021.760320] [38959] 0 38959 296615 4025 57 10 0 0 image [304021.769236] [38961] 0 38961 296967 4020 59 10 0 0 image [304021.778060] [38992] 0 38992 405224 4813 85 10 0 0 exe [304021.786762] [38995] 0 38995 388776 4916 84 10 0 0 exe [304021.795668] [38997] 0 38997 774932 16311 326 14 0 0 exe [304021.804787] [38998] 0 38998 386727 4754 84 10 0 0 exe [304021.813445] [38999] 0 38999 71207044 5753278 18182 63 0 0 exe [304021.822259] [39001] 0 39001 809942 16776 329 15 0 0 exe [304021.830932] [39511] 0 39511 1 1 1 1 0 0 exe [304021.840629] [39515] 0 39515 1 1 1 1 0 0 exe [304021.849457] [39519] 0 39519 1 1 1 1 0 0 exe [304021.858118] [39604] 0 39604 23895 4111 52 6 0 0 exe [304021.867192] [39638] 0 39638 23812 4163 52 6 0 0 exe [304021.879052] [39645] 0 39645 23772 4273 52 6 0 0 exe [304021.888242] [43019] 0 43019 179818 678 21 5 0 0 image [304021.897067] [43023] 0 43023 180234 702 22 4 0 0 image [304021.911010] [43029] 0 43029 179882 691 21 5 0 0 image [304021.920457] [43040] 0 43040 181454 710 24 5 0 0 exe [304021.929721] [43041] 0 43041 180974 861 23 5 0 0 exe [304021.938903] [43042] 0 43042 181038 734 23 5 0 0 exe [304021.948071] [43043] 65534 43043 16404379 5015964 22283 52 0 0 exe [304021.956714] [43044] 65534 43044 211120 4823 56 5 0 0 exe [304021.965364] [43049] 65534 43049 211184 4959 56 5 0 0 exe [304021.974001] [43126] 65534 43126 1 1 1 1 0 0 exe [304021.983455] [43131] 65534 43131 1 1 1 1 0 0 exe [304021.992093] [43136] 65534 43136 1 1 1 1 0 0 exe [304022.000739] [43181] 65534 43181 23934 3583 52 6 0 0 exe [304022.009378] [43196] 65534 43196 23691 3883 51 6 0 0 exe [304022.018015] [43207] 65534 43207 23659 3316 52 6 0 0 exe [304022.026658] [43909] 0 43909 296967 3701 59 10 0 0 image [304022.035479] [43917] 0 43917 29069 3572 29 6 0 0 exe [304022.048254] [44040] 0 44040 1 1 1 1 0 0 exe [304022.058424] [44059] 0 44059 1 1 1 1 0 0 exe [304022.067122] [44063] 0 44063 1 1 1 1 0 0 exe [304022.078280] [44068] 0 44068 1 1 1 1 0 0 exe [304022.087365] [44072] 0 44072 6608 1 9 5 0 0 exe [304022.096300] [44089] 0 44089 1 1 1 1 0 0 exe [304022.105053] [44094] 0 44094 668 1 5 4 0 0 exe [304022.115939] [44099] 0 44099 4762 1 5 4 0 0 exe [304022.127976] [44152] 0 44152 6463 1 9 5 0 0 exe [304022.136731] [44156] 0 44156 6544 1 9 5 0 0 exe [304022.145465] [44185] 0 44185 1 1 1 1 0 0 exe [304022.154191] [44976] 0 44976 180170 617 21 4 0 0 image [304022.163003] [44983] 65534 44983 29017 3280 29 6 0 0 exe [304022.171641] [45009] 65534 45009 509 1 5 4 0 0 exe [304022.180282] [45031] 65534 45031 648 1 5 4 0 0 exe [304022.188921] [45036] 65534 45036 4603 1 5 4 0 0 exe [304022.197558] [45043] 65534 45043 541 1 5 4 0 0 exe [304022.206315] [45047] 65534 45047 4742 1 5 4 0 0 exe [304022.214957] [45060] 65534 45060 736 1 5 4 0 0 exe [304022.223692] [45065] 65534 45065 4635 1 5 4 0 0 exe [304022.232418] [45072] 65534 45072 4830 1 5 4 0 0 exe [304022.241179] [45102] 65534 45102 6447 1 9 5 0 0 exe [304022.249817] [45154] 65534 45154 6586 1 9 5 0 0 exe [304022.258456] [45192] 65534 45192 6479 1 9 5 0 0 exe [304022.267123] [45207] 65534 45207 6676 1 9 5 0 0 exe [304022.275763] [45701] 0 45701 180298 745 22 4 0 0 image [304022.284615] [45717] 0 45717 181390 715 24 4 0 0 exe [304022.293349] [45718] 65534 45718 210928 4803 54 6 0 0 exe [304022.301989] [45767] 65534 45767 1 1 1 1 0 0 exe [304022.310627] [45812] 65534 45812 23461 3524 31 6 0 0 exe [304022.319266] [45930] 0 45930 296903 4041 60 10 0 0 image [304022.328121] [45936] 0 45936 402871 4742 83 10 0 0 exe [304022.336769] [45937] 0 45937 703929 16308 352 15 0 0 exe [304022.345496] [45955] 0 45955 1 1 1 1 0 0 exe [304022.354143] [45967] 0 45967 23495 3162 31 6 0 0 exe [304022.369426] [46182] 0 46182 296615 4058 58 10 0 0 image [304022.378273] [46188] 0 46188 405257 4761 88 10 0 0 exe [304022.386996] [46189] 0 46189 652341 16188 347 15 0 0 exe [304022.395633] [46215] 0 46215 1 1 1 1 0 0 exe [304022.404357] [46275] 0 46275 23849 3358 31 6 0 0 exe [304022.412994] [46384] 0 46384 180359 664 22 4 0 0 image [304022.421811] [46441] 0 46441 2494 20 9 3 0 0 cpp [304022.430450] [46442] 0 46442 2494 20 9 3 0 0 cpp [304022.439090] Out of memory: Kill process 33189 (exe) score 602 or sacrifice child [304022.446859] Killed process 33266 (exe) total-vm:4kB, anon-rss:4kB, file-rss:0kB, shmem-rss:0kB [304022.460168] oom_reaper: reaped process 33266 (exe), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB [304023.358011] exe invoked oom-killer: gfp_mask=0x24201ca(GFP_HIGHUSER_MOVABLE|__GFP_COLD), nodemask=0, order=0, oom_score_adj=0 [304023.369679] exe cpuset=/ mems_allowed=0 [304023.373969] CPU: 7 PID: 43315 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [304023.383900] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [304023.393319] 0000000000000000 ffffffffa1136404 ffffba194f42bc10 ffff9fc5a42f7040 [304023.401409] ffffffffa1009690 0000000000000000 0000000000000000 0000000ca0f8b8e3 [304023.421041] ffff9fbd2db59100 ffffffffa0f8d207 0000004200000000 ffffffffa10acee0 [304023.429152] Call Trace: [304023.431800] [] ? dump_stack+0x5c/0x78 [304023.437315] [] ? dump_header+0x78/0x1fd [304023.442997] [] ? get_page_from_freelist+0x3f7/0xb20 [304023.449719] [] ? cap_inode_killpriv+0x20/0x20 [304023.455919] [] ? oom_kill_process+0x22a/0x3f0 [304023.462119] [] ? out_of_memory+0x111/0x470 [304023.468058] [] ? __alloc_pages_slowpath+0xa1f/0xb30 [304023.474781] [] ? __alloc_pages_nodemask+0x201/0x260 [304023.481504] [] ? alloc_pages_current+0x91/0x140 [304023.487877] [] ? filemap_fault+0x326/0x5d0 [304023.493848] [] ? ext4_filemap_fault+0x31/0x50 [ext4] [304023.500657] [] ? __do_fault+0xa9/0x1c0 [304023.506347] [] ? handle_mm_fault+0xda4/0x1350 [304023.512547] [] ? do_nanosleep+0x8d/0xe0 [304023.518226] [] ? __do_page_fault+0x255/0x4f0 [304023.524344] [] ? page_fault+0x28/0x30 [304023.529921] Mem-Info: [304023.532442] active_anon:30418551 inactive_anon:97561 isolated_anon:0 active_file:317 inactive_file:198 isolated_file:0 unevictable:0 dirty:1 writeback:0 unstable:0 slab_reclaimable:8773 slab_unreclaimable:35244 mapped:91402 shmem:97883 pagetables:116310 bounce:0 free:138813 free_pcp:575 free_cma:0 [304023.566928] Node 0 active_anon:121674204kB inactive_anon:390244kB active_file:2912kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB mapped:365048kB dirty:4kB writeback:0kB shmem:391532kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 180224kB writeback_tmp:0kB unstable:0kB pages_scanned:109 all_unreclaimable? no [304023.597025] Node 0 DMA free:15908kB min:8kB low:20kB high:32kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [304023.626819] lowmem_reserve[]: 0 2974 120837 120837 120837 [304023.633216] Node 0 DMA32 free:473116kB min:1660kB low:4704kB high:7748kB active_anon:2561976kB inactive_anon:21824kB active_file:0kB inactive_file:68kB unevictable:0kB writepending:0kB present:3129320kB managed:3063752kB mlocked:0kB slab_reclaimable:72kB slab_unreclaimable:528kB kernel_stack:340kB pagetables:5172kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [304023.665869] lowmem_reserve[]: 0 0 117862 117862 117862 [304023.671975] Node 0 Normal free:65908kB min:65908kB low:186596kB high:307284kB active_anon:119112392kB inactive_anon:368420kB active_file:2364kB inactive_file:332kB unevictable:0kB writepending:0kB present:122683392kB managed:120696220kB mlocked:0kB slab_reclaimable:34980kB slab_unreclaimable:140380kB kernel_stack:58636kB pagetables:460068kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [304023.706890] lowmem_reserve[]: 0 0 0 0 0 [304023.711723] Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15908kB [304023.728100] Node 0 DMA32: 629*4kB (UMEH) 459*8kB (UME) 256*16kB (UME) 96*32kB (UME) 119*64kB (UME) 138*128kB (UME) 56*256kB (UE) 17*512kB (UE) 2*1024kB (UE) 2*2048kB (UH) 99*4096kB (UM) = 473324kB [304023.748925] Node 0 Normal: 16411*4kB (UMEH) 592*8kB (UMEH) 9*16kB (MH) 8*32kB (H) 8*64kB (H) 2*128kB (H) 1*256kB (H) 1*512kB (H) 0*1024kB 0*2048kB 0*4096kB = 72316kB [304023.766784] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_