D0327 13:43:10.615532 65312 parameters.go:238] Clock(Monotonic): error: -21 ns, adjusted frequency from 2299774232 Hz to 2299774335 Hz D0327 13:43:10.615704 65312 parameters.go:238] Clock(Realtime): error: -116 ns, adjusted frequency from 2299774362 Hz to 2299774111 Hz D0327 13:43:10.615814 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915872072311955 monotonicBaseRef:2000274516 monotonicFrequency:2299774335 realtimeReady:1 realtimeBaseCycles:2915872072749588 realtimeBaseRef:1585316590615699456 realtimeFrequency:2299774111} D0327 13:43:11.615523 65312 parameters.go:238] Clock(Monotonic): error: 277 ns, adjusted frequency from 2299774335 Hz to 2299775112 Hz D0327 13:43:11.615775 65312 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0327 13:43:11.616203 65312 parameters.go:238] Clock(Realtime): error: 626 ns, adjusted frequency from 2299774111 Hz to 2299775799 Hz D0327 13:43:11.616363 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915874372016972 monotonicBaseRef:3000244374 monotonicFrequency:2299775112 realtimeReady:1 realtimeBaseCycles:2915874373662949 realtimeBaseRef:1585316591616194830 realtimeFrequency:2299775799} D0327 13:43:12.615477 65312 parameters.go:238] Clock(Monotonic): error: -201 ns, adjusted frequency from 2299775112 Hz to 2299773991 Hz D0327 13:43:12.615717 65312 parameters.go:238] Clock(Realtime): error: 46 ns, adjusted frequency from 2299775799 Hz to 2299774533 Hz D0327 13:43:12.615833 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915876671727874 monotonicBaseRef:4000216453 monotonicFrequency:2299773991 realtimeReady:1 realtimeBaseCycles:2915876672325059 realtimeBaseRef:1585316592615710570 realtimeFrequency:2299774533} D0327 13:43:13.615557 65312 parameters.go:238] Clock(Monotonic): error: 265 ns, adjusted frequency from 2299773991 Hz to 2299775114 Hz D0327 13:43:13.615877 65312 parameters.go:238] Clock(Realtime): error: -68 ns, adjusted frequency from 2299774533 Hz to 2299774225 Hz D0327 13:43:13.616064 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915878971697274 monotonicBaseRef:5000301421 monotonicFrequency:2299775114 realtimeReady:1 realtimeBaseCycles:2915878972461468 realtimeBaseRef:1585316593615867922 realtimeFrequency:2299774225} D0327 13:43:14.615477 65312 parameters.go:238] Clock(Monotonic): error: -38 ns, adjusted frequency from 2299775114 Hz to 2299774404 Hz D0327 13:43:14.615732 65312 parameters.go:238] Clock(Realtime): error: -91 ns, adjusted frequency from 2299774225 Hz to 2299774289 Hz D0327 13:43:14.615868 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915881271250080 monotonicBaseRef:6000204755 monotonicFrequency:2299774404 realtimeReady:1 realtimeBaseCycles:2915881271905541 realtimeBaseRef:1585316594615724363 realtimeFrequency:2299774289} D0327 13:43:15.615590 65312 parameters.go:238] Clock(Monotonic): error: -154 ns, adjusted frequency from 2299774404 Hz to 2299774139 Hz D0327 13:43:15.615811 65312 parameters.go:238] Clock(Realtime): error: 350 ns, adjusted frequency from 2299774289 Hz to 2299775265 Hz D0327 13:43:15.615994 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915883571338737 monotonicBaseRef:7000341400 monotonicFrequency:2299774139 realtimeReady:1 realtimeBaseCycles:2915883571863814 realtimeBaseRef:1585316595615804363 realtimeFrequency:2299775265} D0327 13:43:16.615584 65312 parameters.go:238] Clock(Monotonic): error: 26 ns, adjusted frequency from 2299774139 Hz to 2299774550 Hz D0327 13:43:16.615846 65312 parameters.go:238] Clock(Realtime): error: -83 ns, adjusted frequency from 2299775265 Hz to 2299774236 Hz D0327 13:43:16.616017 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915885870974970 monotonicBaseRef:8000281434 monotonicFrequency:2299774550 realtimeReady:1 realtimeBaseCycles:2915885871715400 realtimeBaseRef:1585316596615837549 realtimeFrequency:2299774236} D0327 13:43:17.615499 65312 parameters.go:238] Clock(Monotonic): error: 30 ns, adjusted frequency from 2299774550 Hz to 2299774575 Hz D0327 13:43:17.615702 65312 parameters.go:238] Clock(Realtime): error: -130 ns, adjusted frequency from 2299774236 Hz to 2299774167 Hz D0327 13:43:17.615826 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915888170662366 monotonicBaseRef:9000243537 monotonicFrequency:2299774575 realtimeReady:1 realtimeBaseCycles:2915888171167054 realtimeBaseRef:1585316597615697282 realtimeFrequency:2299774167} D0327 13:43:18.615504 65312 parameters.go:238] Clock(Monotonic): error: 192 ns, adjusted frequency from 2299774575 Hz to 2299774994 Hz D0327 13:43:18.615745 65312 parameters.go:238] Clock(Realtime): error: 277 ns, adjusted frequency from 2299774167 Hz to 2299775132 Hz D0327 13:43:18.615936 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915890470456713 monotonicBaseRef:10000252134 monotonicFrequency:2299774994 realtimeReady:1 realtimeBaseCycles:2915890470983752 realtimeBaseRef:1585316598615715775 realtimeFrequency:2299775132} D0327 13:43:19.615527 65312 parameters.go:238] Clock(Monotonic): error: 70 ns, adjusted frequency from 2299774994 Hz to 2299774730 Hz D0327 13:43:19.615807 65312 parameters.go:238] Clock(Realtime): error: -331 ns, adjusted frequency from 2299775132 Hz to 2299773749 Hz D0327 13:43:19.615912 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915892770282103 monotonicBaseRef:11000274047 monotonicFrequency:2299774730 realtimeReady:1 realtimeBaseCycles:2915892770954957 realtimeBaseRef:1585316599615801032 realtimeFrequency:2299773749} D0327 13:43:20.615518 65312 parameters.go:238] Clock(Monotonic): error: -273 ns, adjusted frequency from 2299774730 Hz to 2299773887 Hz D0327 13:43:20.615736 65312 parameters.go:238] Clock(Realtime): error: 626 ns, adjusted frequency from 2299773749 Hz to 2299776016 Hz D0327 13:43:20.615859 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915895070042542 monotonicBaseRef:12000267832 monotonicFrequency:2299773887 realtimeReady:1 realtimeBaseCycles:2915895070561355 realtimeBaseRef:1585316600615728263 realtimeFrequency:2299776016} D0327 13:43:21.615515 65312 parameters.go:238] Clock(Monotonic): error: 294 ns, adjusted frequency from 2299773887 Hz to 2299775250 Hz D0327 13:43:21.615789 65312 parameters.go:238] Clock(Realtime): error: 376 ns, adjusted frequency from 2299776016 Hz to 2299775475 Hz D0327 13:43:21.615935 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915897369804782 monotonicBaseRef:13000262767 monotonicFrequency:2299775250 realtimeReady:1 realtimeBaseCycles:2915897370450727 realtimeBaseRef:1585316601615777553 realtimeFrequency:2299775475} D0327 13:43:22.615541 65312 parameters.go:238] Clock(Monotonic): error: -55 ns, adjusted frequency from 2299775250 Hz to 2299774416 Hz D0327 13:43:22.615794 65312 parameters.go:238] Clock(Realtime): error: -783 ns, adjusted frequency from 2299775475 Hz to 2299772681 Hz D0327 13:43:22.615893 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915899669638088 monotonicBaseRef:14000288011 monotonicFrequency:2299774416 realtimeReady:1 realtimeBaseCycles:2915899670245621 realtimeBaseRef:1585316602615785996 realtimeFrequency:2299772681} D0327 13:43:23.615522 65312 parameters.go:238] Clock(Monotonic): error: -25 ns, adjusted frequency from 2299774416 Hz to 2299774507 Hz D0327 13:43:23.615833 65312 parameters.go:238] Clock(Realtime): error: 364 ns, adjusted frequency from 2299772681 Hz to 2299775340 Hz D0327 13:43:23.615959 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915901969367296 monotonicBaseRef:15000268353 monotonicFrequency:2299774507 realtimeReady:1 realtimeBaseCycles:2915901970107426 realtimeBaseRef:1585316603615824749 realtimeFrequency:2299775340} D0327 13:43:24.615599 65312 parameters.go:238] Clock(Monotonic): error: 19 ns, adjusted frequency from 2299774507 Hz to 2299774611 Hz D0327 13:43:24.615831 65312 parameters.go:238] Clock(Realtime): error: -289 ns, adjusted frequency from 2299775340 Hz to 2299773852 Hz D0327 13:43:24.615966 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915904269254067 monotonicBaseRef:16000317168 monotonicFrequency:2299774611 realtimeReady:1 realtimeBaseCycles:2915904269880850 realtimeBaseRef:1585316604615823915 realtimeFrequency:2299773852} D0327 13:43:25.615532 65312 parameters.go:238] Clock(Monotonic): error: -26 ns, adjusted frequency from 2299774611 Hz to 2299774514 Hz D0327 13:43:25.615742 65312 parameters.go:238] Clock(Realtime): error: -154 ns, adjusted frequency from 2299773852 Hz to 2299774192 Hz D0327 13:43:25.615859 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915906568936921 monotonicBaseRef:17000277269 monotonicFrequency:2299774514 realtimeReady:1 realtimeBaseCycles:2915906569455465 realtimeBaseRef:1585316605615737281 realtimeFrequency:2299774192} D0327 13:43:26.615546 65312 parameters.go:238] Clock(Monotonic): error: -198 ns, adjusted frequency from 2299774514 Hz to 2299774094 Hz D0327 13:43:26.615732 65312 parameters.go:238] Clock(Realtime): error: -8 ns, adjusted frequency from 2299774192 Hz to 2299774541 Hz D0327 13:43:26.615832 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915908868757973 monotonicBaseRef:18000297504 monotonicFrequency:2299774094 realtimeReady:1 realtimeBaseCycles:2915908869208757 realtimeBaseRef:1585316606615728193 realtimeFrequency:2299774541} D0327 13:43:27.615504 65312 parameters.go:238] Clock(Monotonic): error: 200 ns, adjusted frequency from 2299774094 Hz to 2299775012 Hz D0327 13:43:27.615736 65312 parameters.go:238] Clock(Realtime): error: 239 ns, adjusted frequency from 2299774541 Hz to 2299775097 Hz D0327 13:43:27.615891 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915911168427208 monotonicBaseRef:19000251908 monotonicFrequency:2299775012 realtimeReady:1 realtimeBaseCycles:2915911168985653 realtimeBaseRef:1585316607615729217 realtimeFrequency:2299775097} D0327 13:43:28.615541 65312 parameters.go:238] Clock(Monotonic): error: -12 ns, adjusted frequency from 2299775012 Hz to 2299774507 Hz D0327 13:43:28.615871 65312 parameters.go:238] Clock(Realtime): error: 156 ns, adjusted frequency from 2299775097 Hz to 2299774926 Hz D0327 13:43:28.615984 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915913468283983 monotonicBaseRef:20000287460 monotonicFrequency:2299774507 realtimeReady:1 realtimeBaseCycles:2915913469068928 realtimeBaseRef:1585316608615863220 realtimeFrequency:2299774926} D0327 13:43:29.615440 65312 parameters.go:238] Clock(Monotonic): error: -209 ns, adjusted frequency from 2299774507 Hz to 2299774082 Hz D0327 13:43:29.615658 65312 parameters.go:238] Clock(Realtime): error: -486 ns, adjusted frequency from 2299774926 Hz to 2299773391 Hz D0327 13:43:29.615789 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915915767843038 monotonicBaseRef:21000193776 monotonicFrequency:2299774082 realtimeReady:1 realtimeBaseCycles:2915915768359995 realtimeBaseRef:1585316609615652825 realtimeFrequency:2299773391} D0327 13:43:30.615541 65312 parameters.go:238] Clock(Monotonic): error: 203 ns, adjusted frequency from 2299774082 Hz to 2299774998 Hz D0327 13:43:30.615804 65312 parameters.go:238] Clock(Realtime): error: 161 ns, adjusted frequency from 2299773391 Hz to 2299774890 Hz D0327 13:43:30.615962 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915918067832404 monotonicBaseRef:22000287386 monotonicFrequency:2299774998 realtimeReady:1 realtimeBaseCycles:2915918068462116 realtimeBaseRef:1585316610615795765 realtimeFrequency:2299774890} D0327 13:43:31.615495 65312 parameters.go:238] Clock(Monotonic): error: -173 ns, adjusted frequency from 2299774998 Hz to 2299774141 Hz D0327 13:43:31.615706 65312 parameters.go:238] Clock(Realtime): error: -107 ns, adjusted frequency from 2299774890 Hz to 2299774394 Hz D0327 13:43:31.615804 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915920367505987 monotonicBaseRef:23000243288 monotonicFrequency:2299774141 realtimeReady:1 realtimeBaseCycles:2915920368018697 realtimeBaseRef:1585316611615700838 realtimeFrequency:2299774394} D0327 13:43:32.615536 65312 parameters.go:238] Clock(Monotonic): error: -12 ns, adjusted frequency from 2299774141 Hz to 2299774499 Hz D0327 13:43:32.615737 65312 parameters.go:238] Clock(Realtime): error: 6 ns, adjusted frequency from 2299774394 Hz to 2299774567 Hz D0327 13:43:32.615873 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915922667378755 monotonicBaseRef:24000286173 monotonicFrequency:2299774499 realtimeReady:1 realtimeBaseCycles:2915922667833208 realtimeBaseRef:1585316612615718281 realtimeFrequency:2299774567} D0327 13:43:33.615485 65312 parameters.go:238] Clock(Monotonic): error: 6 ns, adjusted frequency from 2299774499 Hz to 2299774543 Hz D0327 13:43:33.615669 65312 parameters.go:238] Clock(Realtime): error: 10 ns, adjusted frequency from 2299774567 Hz to 2299774605 Hz D0327 13:43:33.615777 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915924967034327 monotonicBaseRef:25000234460 monotonicFrequency:2299774543 realtimeReady:1 realtimeBaseCycles:2915924967484006 realtimeBaseRef:1585316613615664463 realtimeFrequency:2299774605} D0327 13:43:34.615524 65312 parameters.go:238] Clock(Monotonic): error: 2 ns, adjusted frequency from 2299774543 Hz to 2299774537 Hz D0327 13:43:34.615694 65312 parameters.go:238] Clock(Realtime): error: -26 ns, adjusted frequency from 2299774605 Hz to 2299774496 Hz D0327 13:43:34.615809 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915927266792556 monotonicBaseRef:26000227366 monotonicFrequency:2299774537 realtimeReady:1 realtimeBaseCycles:2915927267313452 realtimeBaseRef:1585316614615688309 realtimeFrequency:2299774496} D0327 13:43:35.615513 65312 parameters.go:238] Clock(Monotonic): error: 3 ns, adjusted frequency from 2299774537 Hz to 2299774549 Hz D0327 13:43:35.615678 65312 parameters.go:238] Clock(Realtime): error: -27 ns, adjusted frequency from 2299774496 Hz to 2299774467 Hz D0327 13:43:35.615753 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915929566651428 monotonicBaseRef:27000264036 monotonicFrequency:2299774549 realtimeReady:1 realtimeBaseCycles:2915929567053537 realtimeBaseRef:1585316615615673346 realtimeFrequency:2299774467} D0327 13:43:36.615572 65312 parameters.go:238] Clock(Monotonic): error: 238 ns, adjusted frequency from 2299774549 Hz to 2299775094 Hz D0327 13:43:36.615801 65312 parameters.go:238] Clock(Realtime): error: 436 ns, adjusted frequency from 2299774467 Hz to 2299775548 Hz D0327 13:43:36.615991 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915931866552388 monotonicBaseRef:28000319002 monotonicFrequency:2299775094 realtimeReady:1 realtimeBaseCycles:2915931867106303 realtimeBaseRef:1585316616615794357 realtimeFrequency:2299775548} D0327 13:43:37.615530 65312 parameters.go:238] Clock(Monotonic): error: 10 ns, adjusted frequency from 2299775094 Hz to 2299774575 Hz D0327 13:43:37.615795 65312 parameters.go:238] Clock(Realtime): error: -126 ns, adjusted frequency from 2299775548 Hz to 2299774237 Hz D0327 13:43:37.615924 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915934166223318 monotonicBaseRef:29000273708 monotonicFrequency:2299774575 realtimeReady:1 realtimeBaseCycles:2915934166868481 realtimeBaseRef:1585316617615788543 realtimeFrequency:2299774237} D0327 13:43:38.615495 65312 parameters.go:238] Clock(Monotonic): error: -15 ns, adjusted frequency from 2299774575 Hz to 2299774527 Hz D0327 13:43:38.615763 65312 parameters.go:238] Clock(Realtime): error: 23 ns, adjusted frequency from 2299774237 Hz to 2299774604 Hz D0327 13:43:38.615930 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915936465927983 monotonicBaseRef:30000243309 monotonicFrequency:2299774527 realtimeReady:1 realtimeBaseCycles:2915936466569372 realtimeBaseRef:1585316618615756650 realtimeFrequency:2299774604} D0327 13:43:39.615479 65312 parameters.go:238] Clock(Monotonic): error: -212 ns, adjusted frequency from 2299774527 Hz to 2299774054 Hz D0327 13:43:39.615654 65312 parameters.go:238] Clock(Realtime): error: -269 ns, adjusted frequency from 2299774604 Hz to 2299773901 Hz D0327 13:43:39.615769 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915938765677052 monotonicBaseRef:31000232239 monotonicFrequency:2299774054 realtimeReady:1 realtimeBaseCycles:2915938766096315 realtimeBaseRef:1585316619615648960 realtimeFrequency:2299773901} D0327 13:43:40.615400 65312 parameters.go:238] Clock(Monotonic): error: -27 ns, adjusted frequency from 2299774054 Hz to 2299774480 Hz D0327 13:43:40.615618 65312 parameters.go:238] Clock(Realtime): error: 35 ns, adjusted frequency from 2299773901 Hz to 2299774612 Hz D0327 13:43:40.615733 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915941065250989 monotonicBaseRef:32000145223 monotonicFrequency:2299774480 realtimeReady:1 realtimeBaseCycles:2915941065789461 realtimeBaseRef:1585316620615613845 realtimeFrequency:2299774612} D0327 13:43:41.615485 65312 parameters.go:238] Clock(Monotonic): error: 216 ns, adjusted frequency from 2299774480 Hz to 2299775055 Hz D0327 13:43:41.615713 65312 parameters.go:238] Clock(Realtime): error: 50 ns, adjusted frequency from 2299774612 Hz to 2299774673 Hz D0327 13:43:41.615809 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915943365225108 monotonicBaseRef:33000232031 monotonicFrequency:2299775055 realtimeReady:1 realtimeBaseCycles:2915943365781699 realtimeBaseRef:1585316621615708474 realtimeFrequency:2299774673} D0327 13:43:42.615408 65312 parameters.go:238] Clock(Monotonic): error: -26 ns, adjusted frequency from 2299775055 Hz to 2299774504 Hz D0327 13:43:42.615632 65312 parameters.go:238] Clock(Realtime): error: 341 ns, adjusted frequency from 2299774673 Hz to 2299775336 Hz D0327 13:43:42.615791 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915945664819230 monotonicBaseRef:34000153356 monotonicFrequency:2299774504 realtimeReady:1 realtimeBaseCycles:2915945665367648 realtimeBaseRef:1585316622615626412 realtimeFrequency:2299775336} D0327 13:43:43.340285 65312 urpc.go:577] urpc: unmarshal success. D0327 13:43:43.340565 65312 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0327 13:43:43.340961 65312 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 13:43:43.615537 65312 parameters.go:238] Clock(Monotonic): error: -181 ns, adjusted frequency from 2299774504 Hz to 2299774123 Hz D0327 13:43:43.616561 65312 parameters.go:238] Clock(Realtime): error: -315 ns, adjusted frequency from 2299775336 Hz to 2299773914 Hz D0327 13:43:43.616742 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915947964898708 monotonicBaseRef:35000285966 monotonicFrequency:2299774123 realtimeReady:1 realtimeBaseCycles:2915947967255231 realtimeBaseRef:1585316623616544869 realtimeFrequency:2299773914} D0327 13:43:44.615576 65312 parameters.go:238] Clock(Monotonic): error: 163 ns, adjusted frequency from 2299774123 Hz to 2299774932 Hz D0327 13:43:44.615831 65312 parameters.go:238] Clock(Realtime): error: 288 ns, adjusted frequency from 2299773914 Hz to 2299775237 Hz D0327 13:43:44.616065 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915950264654494 monotonicBaseRef:36000277992 monotonicFrequency:2299774932 realtimeReady:1 realtimeBaseCycles:2915950265371746 realtimeBaseRef:1585316624615824189 realtimeFrequency:2299775237} D0327 13:43:45.615506 65312 parameters.go:238] Clock(Monotonic): error: -170 ns, adjusted frequency from 2299774932 Hz to 2299774143 Hz D0327 13:43:45.615679 65312 parameters.go:238] Clock(Realtime): error: -506 ns, adjusted frequency from 2299775237 Hz to 2299773382 Hz D0327 13:43:45.615807 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915952564321788 monotonicBaseRef:37000231188 monotonicFrequency:2299774143 realtimeReady:1 realtimeBaseCycles:2915952564801620 realtimeBaseRef:1585316625615674016 realtimeFrequency:2299773382} D0327 13:43:46.615541 65312 parameters.go:238] Clock(Monotonic): error: 228 ns, adjusted frequency from 2299774143 Hz to 2299775069 Hz D0327 13:43:46.615794 65312 parameters.go:238] Clock(Realtime): error: 275 ns, adjusted frequency from 2299773382 Hz to 2299775180 Hz D0327 13:43:46.615930 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915954864220925 monotonicBaseRef:38000285538 monotonicFrequency:2299775069 realtimeReady:1 realtimeBaseCycles:2915954864838108 realtimeBaseRef:1585316626615788421 realtimeFrequency:2299775180} D0327 13:43:47.615501 65312 parameters.go:238] Clock(Monotonic): error: -32 ns, adjusted frequency from 2299775069 Hz to 2299774480 Hz D0327 13:43:47.615786 65312 parameters.go:238] Clock(Realtime): error: -150 ns, adjusted frequency from 2299775180 Hz to 2299774164 Hz D0327 13:43:47.615951 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915957163909798 monotonicBaseRef:39000248057 monotonicFrequency:2299774480 realtimeReady:1 realtimeBaseCycles:2915957164589595 realtimeBaseRef:1585316627615778118 realtimeFrequency:2299774164} D0327 13:43:48.615458 65312 parameters.go:238] Clock(Monotonic): error: -152 ns, adjusted frequency from 2299774480 Hz to 2299774197 Hz D0327 13:43:48.615654 65312 parameters.go:238] Clock(Realtime): error: -113 ns, adjusted frequency from 2299774164 Hz to 2299774250 Hz D0327 13:43:48.615749 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915959463596826 monotonicBaseRef:40000210030 monotonicFrequency:2299774197 realtimeReady:1 realtimeBaseCycles:2915959464069328 realtimeBaseRef:1585316628615650091 realtimeFrequency:2299774250} D0327 13:43:49.615482 65312 parameters.go:238] Clock(Monotonic): error: 118 ns, adjusted frequency from 2299774197 Hz to 2299774832 Hz D0327 13:43:49.615769 65312 parameters.go:238] Clock(Realtime): error: 298 ns, adjusted frequency from 2299774250 Hz to 2299775260 Hz D0327 13:43:49.615898 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915961763418904 monotonicBaseRef:41000230849 monotonicFrequency:2299774832 realtimeReady:1 realtimeBaseCycles:2915961764102371 realtimeBaseRef:1585316629615762620 realtimeFrequency:2299775260} D0327 13:43:50.615494 65312 parameters.go:238] Clock(Monotonic): error: 16 ns, adjusted frequency from 2299774832 Hz to 2299774584 Hz D0327 13:43:50.615742 65312 parameters.go:238] Clock(Realtime): error: -2 ns, adjusted frequency from 2299775260 Hz to 2299774505 Hz D0327 13:43:50.615874 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915964063213295 monotonicBaseRef:42000239353 monotonicFrequency:2299774584 realtimeReady:1 realtimeBaseCycles:2915964063816280 realtimeBaseRef:1585316630615735943 realtimeFrequency:2299774505} D0327 13:43:51.615484 65312 parameters.go:238] Clock(Monotonic): error: -180 ns, adjusted frequency from 2299774584 Hz to 2299774117 Hz D0327 13:43:51.615688 65312 parameters.go:238] Clock(Realtime): error: -29 ns, adjusted frequency from 2299774505 Hz to 2299774462 Hz D0327 13:43:51.615872 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915966362971377 monotonicBaseRef:43000232177 monotonicFrequency:2299774117 realtimeReady:1 realtimeBaseCycles:2915966363466424 realtimeBaseRef:1585316631615681867 realtimeFrequency:2299774462} D0327 13:43:52.615556 65312 parameters.go:238] Clock(Monotonic): error: 242 ns, adjusted frequency from 2299774117 Hz to 2299775129 Hz D0327 13:43:52.615797 65312 parameters.go:238] Clock(Realtime): error: 153 ns, adjusted frequency from 2299774462 Hz to 2299774827 Hz D0327 13:43:52.615977 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915968662906291 monotonicBaseRef:44000302095 monotonicFrequency:2299775129 realtimeReady:1 realtimeBaseCycles:2915968663490326 realtimeBaseRef:1585316632615790329 realtimeFrequency:2299774827} D0327 13:43:53.615487 65312 parameters.go:238] Clock(Monotonic): error: -233 ns, adjusted frequency from 2299775129 Hz to 2299774002 Hz D0327 13:43:53.615701 65312 parameters.go:238] Clock(Realtime): error: -230 ns, adjusted frequency from 2299774827 Hz to 2299774002 Hz D0327 13:43:53.615817 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915970962526053 monotonicBaseRef:45000234537 monotonicFrequency:2299774002 realtimeReady:1 realtimeBaseCycles:2915970963047656 realtimeBaseRef:1585316633615695755 realtimeFrequency:2299774002} I0327 13:43:53.744564 65312 watchdog.go:277] Watchdog starting loop, tasks: 17, discount: 0s D0327 13:43:54.615513 65312 parameters.go:238] Clock(Monotonic): error: 139 ns, adjusted frequency from 2299774002 Hz to 2299774875 Hz D0327 13:43:54.615756 65312 parameters.go:238] Clock(Realtime): error: 727 ns, adjusted frequency from 2299774002 Hz to 2299776300 Hz D0327 13:43:54.615922 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915973262287116 monotonicBaseRef:46000228910 monotonicFrequency:2299774875 realtimeReady:1 realtimeBaseCycles:2915973262940564 realtimeBaseRef:1585316634615747458 realtimeFrequency:2299776300} D0327 13:43:55.615501 65312 parameters.go:238] Clock(Monotonic): error: 43 ns, adjusted frequency from 2299774875 Hz to 2299774645 Hz D0327 13:43:55.615823 65312 parameters.go:238] Clock(Realtime): error: -449 ns, adjusted frequency from 2299776300 Hz to 2299773493 Hz D0327 13:43:55.615994 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915975562101977 monotonicBaseRef:47000246296 monotonicFrequency:2299774645 realtimeReady:1 realtimeBaseCycles:2915975562873680 realtimeBaseRef:1585316635615815645 realtimeFrequency:2299773493} D0327 13:43:56.615465 65312 parameters.go:238] Clock(Monotonic): error: -169 ns, adjusted frequency from 2299774645 Hz to 2299774128 Hz D0327 13:43:56.615658 65312 parameters.go:238] Clock(Realtime): error: -393 ns, adjusted frequency from 2299773493 Hz to 2299773687 Hz D0327 13:43:56.615753 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915977861781170 monotonicBaseRef:48000204791 monotonicFrequency:2299774128 realtimeReady:1 realtimeBaseCycles:2915977862274023 realtimeBaseRef:1585316636615653389 realtimeFrequency:2299773687} D0327 13:43:57.615437 65312 parameters.go:238] Clock(Monotonic): error: 15 ns, adjusted frequency from 2299774128 Hz to 2299774585 Hz D0327 13:43:57.615631 65312 parameters.go:238] Clock(Realtime): error: 323 ns, adjusted frequency from 2299773687 Hz to 2299775326 Hz D0327 13:43:57.615739 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915980161517280 monotonicBaseRef:49000188259 monotonicFrequency:2299774585 realtimeReady:1 realtimeBaseCycles:2915980161982642 realtimeBaseRef:1585316637615625095 realtimeFrequency:2299775326} D0327 13:43:58.018629 65312 urpc.go:577] urpc: unmarshal success. D0327 13:43:58.018849 65312 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0327 13:43:58.019244 65312 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 13:43:58.615462 65312 parameters.go:238] Clock(Monotonic): error: -21 ns, adjusted frequency from 2299774585 Hz to 2299774489 Hz D0327 13:43:58.615710 65312 parameters.go:238] Clock(Realtime): error: -354 ns, adjusted frequency from 2299775326 Hz to 2299773706 Hz D0327 13:43:58.615796 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915982461332523 monotonicBaseRef:50000205938 monotonicFrequency:2299774489 realtimeReady:1 realtimeBaseCycles:2915982461942793 realtimeBaseRef:1585316638615705461 realtimeFrequency:2299773706} D0327 13:43:59.615547 65312 parameters.go:238] Clock(Monotonic): error: -17 ns, adjusted frequency from 2299774489 Hz to 2299774496 Hz D0327 13:43:59.615723 65312 parameters.go:238] Clock(Realtime): error: -10 ns, adjusted frequency from 2299773706 Hz to 2299774541 Hz D0327 13:43:59.615842 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915984761326990 monotonicBaseRef:51000301589 monotonicFrequency:2299774496 realtimeReady:1 realtimeBaseCycles:2915984761747885 realtimeBaseRef:1585316639615719108 realtimeFrequency:2299774541} D0327 13:44:00.615543 65312 parameters.go:238] Clock(Monotonic): error: 36 ns, adjusted frequency from 2299774496 Hz to 2299774616 Hz D0327 13:44:00.615796 65312 parameters.go:238] Clock(Realtime): error: 312 ns, adjusted frequency from 2299774541 Hz to 2299775271 Hz D0327 13:44:00.615946 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915987061077455 monotonicBaseRef:52000291139 monotonicFrequency:2299774616 realtimeReady:1 realtimeBaseCycles:2915987061686474 realtimeBaseRef:1585316640615790440 realtimeFrequency:2299775271} D0327 13:44:01.615495 65312 parameters.go:238] Clock(Monotonic): error: 61 ns, adjusted frequency from 2299774616 Hz to 2299774678 Hz D0327 13:44:01.615776 65312 parameters.go:238] Clock(Realtime): error: -5 ns, adjusted frequency from 2299775271 Hz to 2299774554 Hz D0327 13:44:01.615904 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915989360728924 monotonicBaseRef:53000237591 monotonicFrequency:2299774678 realtimeReady:1 realtimeBaseCycles:2915989361409657 realtimeBaseRef:1585316641615767790 realtimeFrequency:2299774554} D0327 13:44:02.615417 65312 parameters.go:238] Clock(Monotonic): error: -72 ns, adjusted frequency from 2299774678 Hz to 2299774384 Hz D0327 13:44:02.615618 65312 parameters.go:238] Clock(Realtime): error: -270 ns, adjusted frequency from 2299774554 Hz to 2299773930 Hz D0327 13:44:02.615760 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915991660340186 monotonicBaseRef:54000166533 monotonicFrequency:2299774384 realtimeReady:1 realtimeBaseCycles:2915991660828670 realtimeBaseRef:1585316642615613191 realtimeFrequency:2299773930} D0327 13:44:03.615561 65312 parameters.go:238] Clock(Monotonic): error: 14 ns, adjusted frequency from 2299774384 Hz to 2299774573 Hz D0327 13:44:03.615809 65312 parameters.go:238] Clock(Realtime): error: 309 ns, adjusted frequency from 2299773930 Hz to 2299775194 Hz D0327 13:44:03.615905 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915993960440123 monotonicBaseRef:55000308091 monotonicFrequency:2299774573 realtimeReady:1 realtimeBaseCycles:2915993961036365 realtimeBaseRef:1585316643615801803 realtimeFrequency:2299775194} D0327 13:44:04.615514 65312 parameters.go:238] Clock(Monotonic): error: 202 ns, adjusted frequency from 2299774573 Hz to 2299775015 Hz D0327 13:44:04.615737 65312 parameters.go:238] Clock(Realtime): error: -413 ns, adjusted frequency from 2299775194 Hz to 2299773651 Hz D0327 13:44:04.615886 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915996260074684 monotonicBaseRef:56000247210 monotonicFrequency:2299775015 realtimeReady:1 realtimeBaseCycles:2915996260647719 realtimeBaseRef:1585316644615730561 realtimeFrequency:2299773651} D0327 13:44:05.615551 65312 parameters.go:238] Clock(Monotonic): error: -1 ns, adjusted frequency from 2299775015 Hz to 2299774569 Hz D0327 13:44:05.615795 65312 parameters.go:238] Clock(Realtime): error: 769 ns, adjusted frequency from 2299773651 Hz to 2299776311 Hz D0327 13:44:05.615962 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2915998559960466 monotonicBaseRef:57000295374 monotonicFrequency:2299774569 realtimeReady:1 realtimeBaseCycles:2915998560557046 realtimeBaseRef:1585316645615789556 realtimeFrequency:2299776311} D0327 13:44:06.615541 65312 parameters.go:238] Clock(Monotonic): error: -221 ns, adjusted frequency from 2299774569 Hz to 2299774035 Hz D0327 13:44:06.615828 65312 parameters.go:238] Clock(Realtime): error: -403 ns, adjusted frequency from 2299776311 Hz to 2299773622 Hz D0327 13:44:06.615944 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916000859723453 monotonicBaseRef:58000290337 monotonicFrequency:2299774035 realtimeReady:1 realtimeBaseCycles:2916000860403393 realtimeBaseRef:1585316646615820009 realtimeFrequency:2299773622} D0327 13:44:07.615473 65312 parameters.go:238] Clock(Monotonic): error: -2 ns, adjusted frequency from 2299774035 Hz to 2299774540 Hz D0327 13:44:07.615689 65312 parameters.go:238] Clock(Realtime): error: 48 ns, adjusted frequency from 2299773622 Hz to 2299774685 Hz D0327 13:44:07.615814 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916003159342560 monotonicBaseRef:59000222970 monotonicFrequency:2299774540 realtimeReady:1 realtimeBaseCycles:2916003159848306 realtimeBaseRef:1585316647615677077 realtimeFrequency:2299774685} D0327 13:44:08.615592 65312 parameters.go:238] Clock(Monotonic): error: 9 ns, adjusted frequency from 2299774540 Hz to 2299774572 Hz D0327 13:44:08.615916 65312 parameters.go:238] Clock(Realtime): error: -250 ns, adjusted frequency from 2299774685 Hz to 2299774010 Hz D0327 13:44:08.616115 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916005459394565 monotonicBaseRef:60000343618 monotonicFrequency:2299774572 realtimeReady:1 realtimeBaseCycles:2916005460142684 realtimeBaseRef:1585316648615903052 realtimeFrequency:2299774010} D0327 13:44:09.615536 65312 parameters.go:238] Clock(Monotonic): error: 19 ns, adjusted frequency from 2299774572 Hz to 2299774608 Hz D0327 13:44:09.615727 65312 parameters.go:238] Clock(Realtime): error: -152 ns, adjusted frequency from 2299774010 Hz to 2299774193 Hz D0327 13:44:09.615825 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916007759044884 monotonicBaseRef:61000289589 monotonicFrequency:2299774608 realtimeReady:1 realtimeBaseCycles:2916007759502857 realtimeBaseRef:1585316649615723105 realtimeFrequency:2299774193} D0327 13:44:10.615495 65312 parameters.go:238] Clock(Monotonic): error: -39 ns, adjusted frequency from 2299774608 Hz to 2299774451 Hz D0327 13:44:10.615764 65312 parameters.go:238] Clock(Realtime): error: 303 ns, adjusted frequency from 2299774193 Hz to 2299775199 Hz D0327 13:44:10.615898 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916010058695558 monotonicBaseRef:62000235699 monotonicFrequency:2299774451 realtimeReady:1 realtimeBaseCycles:2916010059354988 realtimeBaseRef:1585316650615756994 realtimeFrequency:2299775199} D0327 13:44:11.615483 65312 parameters.go:238] Clock(Monotonic): error: 44 ns, adjusted frequency from 2299774451 Hz to 2299774651 Hz D0327 13:44:11.615718 65312 parameters.go:238] Clock(Realtime): error: -187 ns, adjusted frequency from 2299775199 Hz to 2299774107 Hz D0327 13:44:11.615828 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916012358447115 monotonicBaseRef:63000225744 monotonicFrequency:2299774651 realtimeReady:1 realtimeBaseCycles:2916012359027719 realtimeBaseRef:1585316651615712438 realtimeFrequency:2299774107} D0327 13:44:12.615507 65312 parameters.go:238] Clock(Monotonic): error: 76 ns, adjusted frequency from 2299774651 Hz to 2299774720 Hz D0327 13:44:12.615740 65312 parameters.go:238] Clock(Realtime): error: 310 ns, adjusted frequency from 2299774107 Hz to 2299775250 Hz D0327 13:44:12.615872 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916014658286225 monotonicBaseRef:64000253772 monotonicFrequency:2299774720 realtimeReady:1 realtimeBaseCycles:2916014658847929 realtimeBaseRef:1585316652615732484 realtimeFrequency:2299775250} D0327 13:44:13.615590 65312 parameters.go:238] Clock(Monotonic): error: 121 ns, adjusted frequency from 2299774720 Hz to 2299774823 Hz D0327 13:44:13.615803 65312 parameters.go:238] Clock(Realtime): error: -274 ns, adjusted frequency from 2299775250 Hz to 2299773892 Hz D0327 13:44:13.615887 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916016958255659 monotonicBaseRef:65000338438 monotonicFrequency:2299774823 realtimeReady:1 realtimeBaseCycles:2916016958775068 realtimeBaseRef:1585316653615798529 realtimeFrequency:2299773892} D0327 13:44:14.615507 65312 parameters.go:238] Clock(Monotonic): error: -232 ns, adjusted frequency from 2299774823 Hz to 2299774004 Hz D0327 13:44:14.615715 65312 parameters.go:238] Clock(Realtime): error: -62 ns, adjusted frequency from 2299773892 Hz to 2299774409 Hz D0327 13:44:14.615831 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916019257749260 monotonicBaseRef:66000216155 monotonicFrequency:2299774004 realtimeReady:1 realtimeBaseCycles:2916019258345378 realtimeBaseRef:1585316654615710006 realtimeFrequency:2299774409} D0327 13:44:15.615519 65312 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0327 13:44:15.615802 65312 parameters.go:238] Clock(Monotonic): error: 586 ns, adjusted frequency from 2299774004 Hz to 2299775887 Hz D0327 13:44:15.615964 65312 parameters.go:238] Clock(Realtime): error: 395 ns, adjusted frequency from 2299774409 Hz to 2299775439 Hz D0327 13:44:15.616114 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916021558305546 monotonicBaseRef:67000556311 monotonicFrequency:2299775887 realtimeReady:1 realtimeBaseCycles:2916021558690218 realtimeBaseRef:1585316655615958043 realtimeFrequency:2299775439} D0327 13:44:16.615413 65312 parameters.go:238] Clock(Monotonic): error: -392 ns, adjusted frequency from 2299775887 Hz to 2299773646 Hz D0327 13:44:16.615661 65312 parameters.go:238] Clock(Realtime): error: -127 ns, adjusted frequency from 2299775439 Hz to 2299774205 Hz D0327 13:44:16.615848 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916023857173466 monotonicBaseRef:68000161504 monotonicFrequency:2299773646 realtimeReady:1 realtimeBaseCycles:2916023857764229 realtimeBaseRef:1585316656615653044 realtimeFrequency:2299774205} D0327 13:44:17.615512 65312 parameters.go:238] Clock(Monotonic): error: -18 ns, adjusted frequency from 2299773646 Hz to 2299774381 Hz D0327 13:44:17.615703 65312 parameters.go:238] Clock(Realtime): error: -273 ns, adjusted frequency from 2299774205 Hz to 2299773897 Hz D0327 13:44:17.615869 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916026157177430 monotonicBaseRef:69000261652 monotonicFrequency:2299774381 realtimeReady:1 realtimeBaseCycles:2916026157641040 realtimeBaseRef:1585316657615697659 realtimeFrequency:2299773897} D0327 13:44:18.615473 65312 parameters.go:238] Clock(Monotonic): error: 256 ns, adjusted frequency from 2299774381 Hz to 2299775023 Hz D0327 13:44:18.615664 65312 parameters.go:238] Clock(Realtime): error: 97 ns, adjusted frequency from 2299773897 Hz to 2299774786 Hz D0327 13:44:18.615781 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916028456865970 monotonicBaseRef:70000224326 monotonicFrequency:2299775023 realtimeReady:1 realtimeBaseCycles:2916028457327341 realtimeBaseRef:1585316658615659570 realtimeFrequency:2299774786} D0327 13:44:19.615538 65312 parameters.go:238] Clock(Monotonic): error: -12 ns, adjusted frequency from 2299775023 Hz to 2299774403 Hz D0327 13:44:19.615717 65312 parameters.go:238] Clock(Realtime): error: -79 ns, adjusted frequency from 2299774786 Hz to 2299774403 Hz D0327 13:44:19.615801 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916030756794382 monotonicBaseRef:71000291023 monotonicFrequency:2299774403 realtimeReady:1 realtimeBaseCycles:2916030757222186 realtimeBaseRef:1585316659615711774 realtimeFrequency:2299774403} D0327 13:44:20.615514 65312 parameters.go:238] Clock(Monotonic): error: -57 ns, adjusted frequency from 2299774403 Hz to 2299774424 Hz D0327 13:44:20.615741 65312 parameters.go:238] Clock(Realtime): error: 116 ns, adjusted frequency from 2299774403 Hz to 2299774814 Hz D0327 13:44:20.615931 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916033056489814 monotonicBaseRef:72000256684 monotonicFrequency:2299774424 realtimeReady:1 realtimeBaseCycles:2916033057049623 realtimeBaseRef:1585316660615734834 realtimeFrequency:2299774814} D0327 13:44:21.615572 65312 parameters.go:238] Clock(Monotonic): error: 349 ns, adjusted frequency from 2299774424 Hz to 2299775229 Hz D0327 13:44:21.615851 65312 parameters.go:238] Clock(Realtime): error: 54 ns, adjusted frequency from 2299774814 Hz to 2299774643 Hz D0327 13:44:21.616003 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916035356396917 monotonicBaseRef:73000314376 monotonicFrequency:2299775229 realtimeReady:1 realtimeBaseCycles:2916035357077804 realtimeBaseRef:1585316661615845004 realtimeFrequency:2299774643} D0327 13:44:22.615547 65312 parameters.go:238] Clock(Monotonic): error: 166 ns, adjusted frequency from 2299775229 Hz to 2299774837 Hz D0327 13:44:22.615785 65312 parameters.go:238] Clock(Realtime): error: -102 ns, adjusted frequency from 2299774643 Hz to 2299774297 Hz D0327 13:44:22.615876 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916037656112842 monotonicBaseRef:74000288589 monotonicFrequency:2299774837 realtimeReady:1 realtimeBaseCycles:2916037656704737 realtimeBaseRef:1585316662615780775 realtimeFrequency:2299774297} D0327 13:44:23.615571 65312 parameters.go:238] Clock(Monotonic): error: -244 ns, adjusted frequency from 2299774837 Hz to 2299774000 Hz D0327 13:44:23.615808 65312 parameters.go:238] Clock(Realtime): error: 514 ns, adjusted frequency from 2299774297 Hz to 2299775820 Hz D0327 13:44:23.616004 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916039955927629 monotonicBaseRef:75000305960 monotonicFrequency:2299774000 realtimeReady:1 realtimeBaseCycles:2916039956525403 realtimeBaseRef:1585316663615800937 realtimeFrequency:2299775820} D0327 13:44:24.615523 65312 parameters.go:238] Clock(Monotonic): error: 36 ns, adjusted frequency from 2299774000 Hz to 2299774575 Hz D0327 13:44:24.615769 65312 parameters.go:238] Clock(Realtime): error: -413 ns, adjusted frequency from 2299775820 Hz to 2299773599 Hz D0327 13:44:24.615903 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916042255558182 monotonicBaseRef:76000243585 monotonicFrequency:2299774575 realtimeReady:1 realtimeBaseCycles:2916042256211258 realtimeBaseRef:1585316664615761817 realtimeFrequency:2299773599} D0327 13:44:25.615527 65312 parameters.go:238] Clock(Monotonic): error: 92 ns, adjusted frequency from 2299774575 Hz to 2299774670 Hz D0327 13:44:25.615705 65312 parameters.go:238] Clock(Realtime): error: 37 ns, adjusted frequency from 2299773599 Hz to 2299774668 Hz D0327 13:44:25.616900 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916044555400530 monotonicBaseRef:77000273054 monotonicFrequency:2299774670 realtimeReady:1 realtimeBaseCycles:2916044555840799 realtimeBaseRef:1585316665615699176 realtimeFrequency:2299774668} D0327 13:44:26.615503 65312 parameters.go:238] Clock(Monotonic): error: -288 ns, adjusted frequency from 2299774670 Hz to 2299773897 Hz D0327 13:44:26.615718 65312 parameters.go:238] Clock(Realtime): error: -268 ns, adjusted frequency from 2299774668 Hz to 2299773927 Hz D0327 13:44:26.615820 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916046855120494 monotonicBaseRef:78000249266 monotonicFrequency:2299773897 realtimeReady:1 realtimeBaseCycles:2916046855648089 realtimeBaseRef:1585316666615713360 realtimeFrequency:2299773927} D0327 13:44:27.615453 65312 parameters.go:238] Clock(Monotonic): error: 190 ns, adjusted frequency from 2299773897 Hz to 2299775068 Hz D0327 13:44:27.615660 65312 parameters.go:238] Clock(Realtime): error: 5 ns, adjusted frequency from 2299773927 Hz to 2299774535 Hz D0327 13:44:27.615775 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916049154779616 monotonicBaseRef:79000199358 monotonicFrequency:2299775068 realtimeReady:1 realtimeBaseCycles:2916049155290456 realtimeBaseRef:1585316667615656154 realtimeFrequency:2299774535} D0327 13:44:28.615455 65312 parameters.go:238] Clock(Monotonic): error: -11 ns, adjusted frequency from 2299775068 Hz to 2299774587 Hz D0327 13:44:28.615660 65312 parameters.go:238] Clock(Realtime): error: 32 ns, adjusted frequency from 2299774535 Hz to 2299774624 Hz D0327 13:44:28.615765 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916051454557989 monotonicBaseRef:80000200795 monotonicFrequency:2299774587 realtimeReady:1 realtimeBaseCycles:2916051455064857 realtimeBaseRef:1585316668615656095 realtimeFrequency:2299774624} D0327 13:44:29.615432 65312 parameters.go:238] Clock(Monotonic): error: 299 ns, adjusted frequency from 2299774587 Hz to 2299775162 Hz D0327 13:44:29.615704 65312 parameters.go:238] Clock(Realtime): error: -18 ns, adjusted frequency from 2299774624 Hz to 2299774510 Hz D0327 13:44:29.615850 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916053754290332 monotonicBaseRef:81000182426 monotonicFrequency:2299775162 realtimeReady:1 realtimeBaseCycles:2916053754934536 realtimeBaseRef:1585316669615697427 realtimeFrequency:2299774510} D0327 13:44:30.615488 65312 parameters.go:238] Clock(Monotonic): error: -288 ns, adjusted frequency from 2299775162 Hz to 2299773940 Hz D0327 13:44:30.615730 65312 parameters.go:238] Clock(Realtime): error: 141 ns, adjusted frequency from 2299774510 Hz to 2299774912 Hz D0327 13:44:30.615866 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916056054196285 monotonicBaseRef:82000239297 monotonicFrequency:2299773940 realtimeReady:1 realtimeBaseCycles:2916056054768557 realtimeBaseRef:1585316670615723303 realtimeFrequency:2299774912} D0327 13:44:31.615479 65312 parameters.go:238] Clock(Monotonic): error: -53 ns, adjusted frequency from 2299773940 Hz to 2299774469 Hz D0327 13:44:31.615724 65312 parameters.go:238] Clock(Realtime): error: -50 ns, adjusted frequency from 2299774912 Hz to 2299774409 Hz D0327 13:44:31.615887 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916058353937857 monotonicBaseRef:83000225222 monotonicFrequency:2299774469 realtimeReady:1 realtimeBaseCycles:2916058354532388 realtimeBaseRef:1585316671615718484 realtimeFrequency:2299774409} I0327 13:44:32.053955 2987 main.go:305] *************************** I0327 13:44:32.054073 2987 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot exec -user=0:0 -cap CAP_CHOWN -cap CAP_DAC_OVERRIDE -cap CAP_DAC_READ_SEARCH -cap CAP_FOWNER -cap CAP_FSETID -cap CAP_KILL -cap CAP_SETGID -cap CAP_SETUID -cap CAP_SETPCAP -cap CAP_LINUX_IMMUTABLE -cap CAP_NET_BIND_SERVICE -cap CAP_NET_BROADCAST -cap CAP_NET_ADMIN -cap CAP_NET_RAW -cap CAP_IPC_LOCK -cap CAP_IPC_OWNER -cap CAP_SYS_MODULE -cap CAP_SYS_RAWIO -cap CAP_SYS_CHROOT -cap CAP_SYS_PTRACE -cap CAP_SYS_PACCT -cap CAP_SYS_ADMIN -cap CAP_SYS_BOOT -cap CAP_SYS_NICE -cap CAP_SYS_RESOURCE -cap CAP_SYS_TIME -cap CAP_SYS_TTY_CONFIG -cap CAP_MKNOD -cap CAP_LEASE -cap CAP_AUDIT_WRITE -cap CAP_AUDIT_CONTROL -cap CAP_SETFCAP -cap CAP_MAC_OVERRIDE -cap CAP_MAC_ADMIN -cap CAP_SYSLOG -cap CAP_WAKE_ALARM -cap CAP_BLOCK_SUSPEND -cap CAP_AUDIT_READ ci-gvisor-ptrace-proxy-sandbox-race-2 /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller159620863] I0327 13:44:32.054436 2987 main.go:307] Version release-20200219.0-252-g76a7ace751bf I0327 13:44:32.054494 2987 main.go:308] PID: 2987 I0327 13:44:32.054584 2987 main.go:309] UID: 0, GID: 0 I0327 13:44:32.054652 2987 main.go:310] Configuration: I0327 13:44:32.054715 2987 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0327 13:44:32.054790 2987 main.go:312] Platform: ptrace I0327 13:44:32.054850 2987 main.go:313] FileAccess: shared, overlay: false I0327 13:44:32.054920 2987 main.go:314] Network: sandbox, logging: false I0327 13:44:32.055117 2987 main.go:315] Strace: false, max size: 1024, syscalls: [] I0327 13:44:32.055203 2987 main.go:316] *************************** W0327 13:44:32.055284 2987 main.go:321] Block the TERM signal. This is only safe in tests! D0327 13:44:32.055591 2987 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.060877 2987 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0327 13:44:32.060991 2987 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.061092 2987 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.061447 2987 urpc.go:534] urpc: successfully marshalled 117 bytes. D0327 13:44:32.061713 65312 urpc.go:577] urpc: unmarshal success. D0327 13:44:32.061966 65312 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0327 13:44:32.062215 65312 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 13:44:32.062420 2987 urpc.go:577] urpc: unmarshal success. D0327 13:44:32.062587 2987 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 /syzkaller159620863 D0327 13:44:32.062751 2987 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0327 13:44:32.062912 2987 container.go:533] Execute in container "ci-gvisor-ptrace-proxy-sandbox-race-2", args: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller159620863 D0327 13:44:32.063065 2987 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-2" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.063202 2987 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.063932 2987 urpc.go:534] urpc: successfully marshalled 636 bytes. D0327 13:44:32.064267 65312 urpc.go:577] urpc: unmarshal success. D0327 13:44:32.065312 65312 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 /syzkaller159620863 D0327 13:44:32.065568 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0327 13:44:32.066325 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.066438 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 13:44:32.066844 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} I0327 13:44:32.067253 65312 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 /syzkaller159620863] D0327 13:44:32.067893 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0327 13:44:32.069055 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398869}]} D0327 13:44:32.069345 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0327 13:44:32.069913 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.070169 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 13:44:32.071238 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 13:44:32.071389 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalk{FID: 5, NewFID: 6, Names: []} D0327 13:44:32.072027 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rwalk{QIDs: []} D0327 13:44:32.072171 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tlopen{FID: 6, Flags: ReadOnly} D0327 13:44:32.073145 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19398869}, IoUnit: 0, File: &{{37}}} D0327 13:44:32.076120 65312 syscalls.go:266] Allocating stack with size of 8388608 bytes D0327 13:44:32.077207 65312 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-2 0}:0xc000500840 {ci-gvisor-ptrace-proxy-sandbox-race-2 23}:0xc0004e81c0] D0327 13:44:32.077465 65312 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 13:44:32.077617 2987 urpc.go:577] urpc: unmarshal success. D0327 13:44:32.077756 2987 container.go:580] Wait on PID 23 in container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.077873 2987 sandbox.go:769] Waiting for PID 23 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.077979 2987 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.078362 2987 urpc.go:534] urpc: successfully marshalled 100 bytes. D0327 13:44:32.078759 65312 urpc.go:577] urpc: unmarshal success. D0327 13:44:32.079041 65312 controller.go:446] containerManager.Wait D0327 13:44:32.079106 65312 task_block.go:223] [ 23] Interrupt queued D0327 13:44:32.264253 65312 task_block.go:223] [ 24] Interrupt queued D0327 13:44:32.265394 65312 task_block.go:223] [ 25] Interrupt queued D0327 13:44:32.267774 65312 task_block.go:223] [ 26] Interrupt queued D0327 13:44:32.277896 65312 task_block.go:223] [ 27] Interrupt queued D0327 13:44:32.290888 65312 task_block.go:223] [ 28] Interrupt queued D0327 13:44:32.300762 65312 task_block.go:223] [ 29] Interrupt queued D0327 13:44:32.315800 65312 task_block.go:223] [ 30] Interrupt queued D0327 13:44:32.327638 65312 urpc.go:577] urpc: unmarshal success. D0327 13:44:32.327885 65312 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0327 13:44:32.328194 65312 urpc.go:534] urpc: successfully marshalled 37 bytes. D0327 13:44:32.351307 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0327 13:44:32.352007 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.352226 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 13:44:32.352816 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.387541 65312 task_block.go:223] [ 31] Interrupt queued D0327 13:44:32.391049 65312 task_block.go:223] [ 32] Interrupt queued D0327 13:44:32.400075 65312 task_block.go:223] [ 33] Interrupt queued D0327 13:44:32.415272 65312 task_block.go:223] [ 34] Interrupt queued D0327 13:44:32.441245 65312 task_block.go:223] [ 35] Interrupt queued D0327 13:44:32.452301 65312 task_block.go:223] [ 36] Interrupt queued D0327 13:44:32.483835 65312 task_block.go:223] [ 37] Interrupt queued D0327 13:44:32.489782 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller159620863]} D0327 13:44:32.489863 65312 task_block.go:223] [ 38] Interrupt queued D0327 13:44:32.491283 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316672, NanoSec: 25513794}, MTime: {Sec: 1585316672, NanoSec: 25513794}, CTime: {Sec: 1585316672, NanoSec: 25513794}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398682}]} D0327 13:44:32.491581 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller159620863, Size: 1} D0327 13:44:32.492031 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.492454 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 13:44:32.493396 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316672, NanoSec: 25513794}, MTime: {Sec: 1585316672, NanoSec: 25513794}, CTime: {Sec: 1585316672, NanoSec: 25513794}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 13:44:32.493556 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalk{FID: 7, NewFID: 8, Names: []} D0327 13:44:32.494187 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rwalk{QIDs: []} D0327 13:44:32.494375 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tlopen{FID: 8, Flags: ReadOnly} D0327 13:44:32.495271 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19398682}, IoUnit: 0, File: &{{31}}} D0327 13:44:32.496600 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 13:44:32.497455 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316672, NanoSec: 25513794}, MTime: {Sec: 1585316672, NanoSec: 25513794}, CTime: {Sec: 1585316672, NanoSec: 25513794}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/27 13:44:32 parsed 1 programs D0327 13:44:32.513887 65312 task_stop.go:118] [ 37] Entering internal stop (*kernel.vforkStop)(nil) D0327 13:44:32.514756 65312 task_block.go:223] [ 39] Interrupt queued D0327 13:44:32.526024 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0327 13:44:32.527437 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398870}]} D0327 13:44:32.527678 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0327 13:44:32.528191 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.528635 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 13:44:32.529624 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 13:44:32.529854 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalk{FID: 9, NewFID: 10, Names: []} D0327 13:44:32.530634 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rwalk{QIDs: []} D0327 13:44:32.530829 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tlopen{FID: 10, Flags: ReadOnly} D0327 13:44:32.531841 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlopen{QID: QID{Type: 0, Version: 0, Path: 19398870}, IoUnit: 0, File: &{{32}}} D0327 13:44:32.532888 65312 syscalls.go:266] [ 39] Allocating stack with size of 8388608 bytes D0327 13:44:32.533881 65312 task_stop.go:137] [ 37] Leaving internal stop (*kernel.vforkStop)(nil) D0327 13:44:32.559101 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0327 13:44:32.560209 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.560418 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 13:44:32.561175 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.564440 65312 task_exit.go:221] [ 39] Transitioning from exit state TaskExitNone to TaskExitInitiated D0327 13:44:32.567323 65312 task_exit.go:221] [ 39] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0327 13:44:32.567542 65312 task_signals.go:446] [ 23] Notified of signal 17 D0327 13:44:32.567642 65312 task_block.go:223] [ 23] Interrupt queued D0327 13:44:32.567779 65312 task_block.go:223] [ 23] Interrupt queued D0327 13:44:32.568049 65312 task_signals.go:179] [ 23] Restarting syscall 202 after errno 512: interrupted by signal 17 D0327 13:44:32.568243 65312 task_signals.go:220] [ 23] Signal 17: delivering to handler D0327 13:44:32.568236 65312 task_exit.go:221] [ 39] Transitioning from exit state TaskExitZombie to TaskExitDead D0327 13:44:32.570260 65312 task_block.go:223] [ 40] Interrupt queued D0327 13:44:32.574747 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0327 13:44:32.576139 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398870}]} D0327 13:44:32.576355 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tclunk{FID: 11} D0327 13:44:32.576842 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rclunk{} D0327 13:44:32.577220 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 13:44:32.578319 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/27 13:44:32 executed programs: 0 D0327 13:44:32.588403 65312 task_stop.go:118] [ 33] Entering internal stop (*kernel.vforkStop)(nil) D0327 13:44:32.589359 65312 task_block.go:223] [ 41] Interrupt queued D0327 13:44:32.603976 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0327 13:44:32.605502 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 19398870}]} D0327 13:44:32.605720 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tclunk{FID: 11} D0327 13:44:32.606135 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rclunk{} D0327 13:44:32.606377 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0327 13:44:32.607405 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] 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: 1585316589, NanoSec: 649439102}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0327 13:44:32.608421 65312 syscalls.go:266] [ 41] Allocating stack with size of 8388608 bytes D0327 13:44:32.609203 65312 task_stop.go:137] [ 33] Leaving internal stop (*kernel.vforkStop)(nil) D0327 13:44:32.615569 65312 parameters.go:238] Clock(Monotonic): error: -29 ns, adjusted frequency from 2299774469 Hz to 2299774427 Hz D0327 13:44:32.615873 65312 parameters.go:238] Clock(Realtime): error: -34 ns, adjusted frequency from 2299774409 Hz to 2299774424 Hz D0327 13:44:32.616020 65312 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:2916060653926830 monotonicBaseRef:84000318493 monotonicFrequency:2299774427 realtimeReady:1 realtimeBaseCycles:2916060654641943 realtimeBaseRef:1585316672615864213 realtimeFrequency:2299774424} D0327 13:44:32.620291 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0327 13:44:32.620919 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.621073 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0327 13:44:32.621545 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.633483 65312 task_block.go:223] [ 42] Interrupt queued D0327 13:44:32.641449 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.642116 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.642249 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.642786 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.643261 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.643737 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.643863 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.644283 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.644776 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.645308 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.645596 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.646163 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.646623 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.647223 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.647431 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.668035 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.668732 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.669419 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.669573 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.669980 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.670459 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.671033 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.671199 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.671652 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.672014 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.672542 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.672698 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.673210 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.673426 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.673993 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.674091 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.674705 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.674986 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.675433 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.675643 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.676073 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.701711 65312 netfilter.go:59] netfilter: convert to binary: current offset: 0 D0327 13:44:32.701890 65312 netfilter.go:59] netfilter: convert to binary: found hook 0 at offset 0 D0327 13:44:32.701976 65312 netfilter.go:59] netfilter: convert to binary: found underflow 0 at offset 0 D0327 13:44:32.702069 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.702158 65312 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 13:44:32.702630 65312 netfilter.go:59] netfilter: convert to binary: current offset: 152 D0327 13:44:32.702679 65312 netfilter.go:59] netfilter: convert to binary: found hook 3 at offset 152 D0327 13:44:32.702748 65312 netfilter.go:59] netfilter: convert to binary: found underflow 3 at offset 152 D0327 13:44:32.702824 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.702931 65312 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 13:44:32.703447 65312 netfilter.go:59] netfilter: convert to binary: current offset: 304 D0327 13:44:32.703534 65312 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 13:44:32.704010 65312 netfilter.go:59] netfilter: convert to binary: finished with an marshalled size of 0 D0327 13:44:32.704060 65312 netfilter.go:59] netfilter: convert to binary: current offset: 0 D0327 13:44:32.704138 65312 netfilter.go:59] netfilter: convert to binary: found hook 1 at offset 0 D0327 13:44:32.704208 65312 netfilter.go:59] netfilter: convert to binary: found underflow 1 at offset 0 D0327 13:44:32.704278 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.704372 65312 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 13:44:32.704930 65312 netfilter.go:59] netfilter: convert to binary: current offset: 152 D0327 13:44:32.705045 65312 netfilter.go:59] netfilter: convert to binary: found hook 2 at offset 152 D0327 13:44:32.705144 65312 netfilter.go:59] netfilter: convert to binary: found underflow 2 at offset 152 D0327 13:44:32.705248 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.705371 65312 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 13:44:32.706020 65312 netfilter.go:59] netfilter: convert to binary: current offset: 304 D0327 13:44:32.706124 65312 netfilter.go:59] netfilter: convert to binary: found hook 3 at offset 304 D0327 13:44:32.706232 65312 netfilter.go:59] netfilter: convert to binary: found underflow 3 at offset 304 D0327 13:44:32.706304 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.706412 65312 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 13:44:32.707019 65312 netfilter.go:59] netfilter: convert to binary: current offset: 456 D0327 13:44:32.707171 65312 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 13:44:32.707947 65312 netfilter.go:59] netfilter: convert to binary: finished with an marshalled size of 0 D0327 13:44:32.708074 65312 netfilter.go:59] netfilter: convert to binary: current offset: 0 D0327 13:44:32.708198 65312 netfilter.go:59] netfilter: convert to binary: found hook 0 at offset 0 D0327 13:44:32.708287 65312 netfilter.go:59] netfilter: convert to binary: found underflow 0 at offset 0 D0327 13:44:32.708376 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.708482 65312 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 13:44:32.709217 65312 netfilter.go:59] netfilter: convert to binary: current offset: 152 D0327 13:44:32.709307 65312 netfilter.go:59] netfilter: convert to binary: found hook 1 at offset 152 D0327 13:44:32.709417 65312 netfilter.go:59] netfilter: convert to binary: found underflow 1 at offset 152 D0327 13:44:32.709538 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.709622 65312 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 13:44:32.710319 65312 netfilter.go:59] netfilter: convert to binary: current offset: 304 D0327 13:44:32.710401 65312 netfilter.go:59] netfilter: convert to binary: found hook 3 at offset 304 D0327 13:44:32.710505 65312 netfilter.go:59] netfilter: convert to binary: found underflow 3 at offset 304 D0327 13:44:32.710605 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.710707 65312 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 13:44:32.711392 65312 netfilter.go:59] netfilter: convert to binary: current offset: 456 D0327 13:44:32.711628 65312 netfilter.go:59] netfilter: convert to binary: found hook 4 at offset 456 D0327 13:44:32.711832 65312 netfilter.go:59] netfilter: convert to binary: found underflow 4 at offset 456 D0327 13:44:32.711943 65312 netfilter.go:59] netfilter: convert to binary: marshalling standard target D0327 13:44:32.712085 65312 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 13:44:32.713081 65312 netfilter.go:59] netfilter: convert to binary: current offset: 608 D0327 13:44:32.713214 65312 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 13:44:32.713973 65312 netfilter.go:59] netfilter: convert to binary: finished with an marshalled size of 0 D0327 13:44:32.917313 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.917936 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.918095 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.918546 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.918842 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.919253 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.919399 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.919802 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.920095 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.920605 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.920762 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.921211 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.921524 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.921917 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.922071 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.922421 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.922749 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.923221 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.923321 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.923710 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.924014 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.924532 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.924662 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.925064 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.925373 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.925904 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.926070 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.926454 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.926805 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.927242 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.927373 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.927749 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.928054 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.928507 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.928670 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.929048 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.929332 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0327 13:44:32.929760 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 2} D0327 13:44:32.929878 65312 transport_flipcall.go:127] send [channel @0xc00064e000] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0327 13:44:32.930220 65312 transport_flipcall.go:234] recv [channel @0xc00064e000] Rlerror{Error: 95} D0327 13:44:32.943071 65312 task_block.go:223] [ 43] Interrupt queued panic: interface conversion: context.Context is kernel.taskAsyncContext, not *kernel.Task goroutine 361 [running]: gvisor.dev/gvisor/pkg/sentry/socket/netstack.(*SocketOperations).Write(0xc0006f41e0, 0x1494640, 0xc0001440e8, 0xc00077ec60, 0x148e240, 0xc000365000, 0x0, 0x1, 0x0, 0x9, ...) pkg/sentry/socket/netstack/netstack.go:538 +0x5d0 gvisor.dev/gvisor/pkg/sentry/fs.(*File).Pwritev(0xc00077ec60, 0x1494640, 0xc0001440e8, 0x148e240, 0xc000365000, 0x0, 0x1, 0x0, 0x9, 0x0, ...) pkg/sentry/fs/file.go:374 +0x270 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.performCallback(0xc00011ea80, 0xc00077ec60, 0x20000000, 0xc0000fe140, 0x148e240, 0xc000365000, 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(0xc00077a460) 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(0xc000534084) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc000534084) 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(0xc000548160, 0x0, 0x0) runsc/boot/loader.go:905 +0x73 gvisor.dev/gvisor/runsc/cmd.(*Boot).Execute(0xc0002282d0, 0x1484580, 0xc0001a4000, 0xc000242300, 0xc000264d60, 0x2, 0x2, 0x0) runsc/cmd/boot.go:260 +0xaf1 github.com/google/subcommands.(*Commander).Execute(0xc0001ba000, 0x1484580, 0xc0001a4000, 0xc000264d60, 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 35 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0x13225f8, 0xc00018a480, 0xc00018a4e0) 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 36 [sync.Cond.Wait]: runtime.goparkunlock(...) GOROOT/src/runtime/proc.go:310 sync.runtime_notifyListWait(0xc000310948, 0x4) GOROOT/src/runtime/sema.go:513 +0xf8 sync.(*Cond).Wait(0xc000310938) GOROOT/src/sync/cond.go:56 +0x8e gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).findReclaimable(0xc000310500, 0x0, 0x0, 0x0) pkg/sentry/pgalloc/pgalloc.go:1090 +0xbe gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).runReclaim(0xc000310500) pkg/sentry/pgalloc/pgalloc.go:1019 +0x7b created by gvisor.dev/gvisor/pkg/sentry/pgalloc.NewMemoryFile pkg/sentry/pgalloc/pgalloc.go:330 +0x2f4 goroutine 37 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater.func1(0xc000242840, 0xc0002d0460) 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 38 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000136000, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000136000, 0xc000372701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372700) 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(0xc00000e060, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00000e060, 0xc000372701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372770) 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(0xc00048e000, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e000, 0xc000372801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003727e0) 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(0xc000136020, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000136020, 0xc000372801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372850) 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(0xc000500000, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500000, 0xc000372801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003728c0) 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(0xc000136040, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000136040, 0xc000372901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372930) 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(0xc000500020, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500020, 0xc000372901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003729a0) 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(0xc00048e020, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e020, 0xc000372a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372a10) 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(0xc000500040, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500040, 0xc000372a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372a80) 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(0xc00048e040, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e040, 0xc000372b01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372af0) 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(0xc00048e060, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e060, 0xc000372b01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372b60) 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(0xc00048e080, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e080, 0xc000372c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372bd0) 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(0xc00048e0a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e0a0, 0xc000372c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372c40) 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 51 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e0c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e0c0, 0xc000372c01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372cb0) 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 52 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000500060, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500060, 0xc000372d01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372d20) 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 53 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000500080, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500080, 0xc000372d01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372d90) 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 54 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e0e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e0e0, 0xc000372e01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372e00) 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 55 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e100, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e100, 0xc000372e01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372e70) 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 56 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0005000a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0005000a0, 0xc000372f01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372ee0) 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 57 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e120, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e120, 0xc000372f01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372f50) 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 58 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e140, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e140, 0xc000372f01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000372fc0) 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 59 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0005000c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0005000c0, 0xc000373001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373030) 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 60 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e160, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e160, 0xc000373001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003730a0) 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 61 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0005000e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0005000e0, 0xc000373101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373110) 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 62 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e180, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e180, 0xc000373101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373180) 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 63 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e1a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e1a0, 0xc000373201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003731f0) 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 64 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000500100, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500100, 0xc000373201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373260) 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 65 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000500120, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500120, 0xc000373301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003732d0) 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(0xc000500140, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500140, 0xc000373301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373340) 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(0xc00048e1c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e1c0, 0xc000373301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003733b0) 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(0xc000500160, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500160, 0xc000373401, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373420) 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(0xc000500180, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500180, 0xc000373401, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373490) 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(0xc00048e1e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e1e0, 0xc000373501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373500) 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(0xc00048e200, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e200, 0xc000373501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373570) 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(0xc00048e220, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e220, 0xc000373601, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003735e0) 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(0xc00048e240, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e240, 0xc000373601, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373650) 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(0xc0005001a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0005001a0, 0xc000373601, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003736c0) 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(0xc00048e260, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e260, 0xc000373701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373730) 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(0xc00048e280, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e280, 0xc000373701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003737a0) 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(0xc0005001c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0005001c0, 0xc000373801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373810) 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(0xc00048e2a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e2a0, 0xc000373801, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373880) 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(0xc00048e2c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e2c0, 0xc000373901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003738f0) 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(0xc0005001e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0005001e0, 0xc000373901, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373960) 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(0xc00048e2e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e2e0, 0xc000373a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0003739d0) 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(0xc000500200, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000500200, 0xc000373a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373a40) 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(0xc0003843a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003843a0, 0xc000373a01, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000373ab0) 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(0xc00048e300, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e300, 0xc000502001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502000) 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(0xc0003843c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003843c0, 0xc000502001, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502070) 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(0xc0003843e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003843e0, 0xc000502101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0005020e0) 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 101 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e320, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e320, 0xc000502101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502150) 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 102 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e340, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e340, 0xc000502101, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0005021c0) 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 103 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000384400, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000384400, 0xc000502201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502230) 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 104 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000384420, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000384420, 0xc000502201, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0005022a0) 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 105 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000384440, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000384440, 0xc000502301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502310) 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 106 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000384460, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000384460, 0xc000502301, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502380) 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 107 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000384480, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000384480, 0xc000502401, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0005023f0) 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 108 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003844a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003844a0, 0xc000502401, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502460) 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 109 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003844c0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003844c0, 0xc000502501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0005024d0) 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 110 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc0003844e0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc0003844e0, 0xc000502501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502540) 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 111 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000384500, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000384500, 0xc000502501, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc0005025b0) 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 112 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc000384520, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc000384520, 0xc000502601, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502620) 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 113 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e360, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e360, 0xc000502601, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502690) 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 114 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e380, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e380, 0xc000502701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502700) 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 115 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sleep.(*Sleeper).nextWaker(0xc00048e3a0, 0x40e101, 0x0) pkg/sleep/sleep_unsafe.go:190 +0x83 gvisor.dev/gvisor/pkg/sleep.(*Sleeper).Fetch(0xc00048e3a0, 0xc000502701, 0x2, 0x0) pkg/sleep/sleep_unsafe.go:225 +0x46 gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*processor).handleSegments(0xc000502770) 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 338 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004ce000) 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 117 [syscall]: syscall.Syscall6(0x10f, 0xc000177e50, 0x2, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:41 +0x5 gvisor.dev/gvisor/pkg/unet.(*Socket).wait(0xc00051cb40, 0xffffffffffffff00, 0x0, 0x0) pkg/unet/unet_unsafe.go:55 +0xe4 gvisor.dev/gvisor/pkg/unet.(*ServerSocket).Accept(0xc00051e028, 0x0, 0x0, 0x0) pkg/unet/unet.go:539 +0x18c gvisor.dev/gvisor/pkg/control/server.(*Server).serve(0xc000500860) pkg/control/server/server.go:99 +0x50 gvisor.dev/gvisor/pkg/control/server.(*Server).StartServing.func1(0xc000500860) 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 215 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000404120) 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 3 [syscall, 1 minutes]: syscall.Syscall6(0x119, 0x14, 0xc0000f0ae0, 0x64, 0xffffffffffffffff, 0x0, 0x0, 0x256b388, 0x256c1a0, 0xc00035a840) src/syscall/asm_linux_amd64.s:41 +0x5 gvisor.dev/gvisor/pkg/fdnotifier.epollWait(0x14, 0xc0000f0ae0, 0x64, 0x64, 0xffffffffffffffff, 0x2, 0x4, 0x756ea1102a300f) pkg/fdnotifier/poll_unsafe.go:77 +0x83 gvisor.dev/gvisor/pkg/fdnotifier.(*notifier).waitAndNotify(0xc00019d420, 0x0, 0x1025400) pkg/fdnotifier/fdnotifier.go:149 +0x9e created by gvisor.dev/gvisor/pkg/fdnotifier.newNotifier pkg/fdnotifier/fdnotifier.go:64 +0x114 goroutine 4 [syscall, 1 minutes]: syscall.Syscall6(0x10f, 0xc0005180c8, 0x1, 0x0, 0x0, 0x0, 0x0, 0x11701e0, 0xc0005180c0, 0x1170c60) src/syscall/asm_linux_amd64.s:41 +0x5 golang.org/x/sys/unix.ppoll(0xc0005180c8, 0x1, 0x0, 0x0, 0x1, 0x1, 0x100000000000001) external/org_golang_x_sys/unix/zsyscall_linux.go:87 +0xa2 golang.org/x/sys/unix.Ppoll(0xc0005180c8, 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(0xc0004aff80, 0x8, 0x0, 0x0, 0x1) runsc/specutils/specutils.go:475 +0x39 gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor.func1(0x7ffd3d3b1f9c, 0x25, 0xc000312a88, 0x1, 0x1, 0xc000548160) runsc/boot/loader.go:708 +0x25a created by gvisor.dev/gvisor/runsc/boot.(*Loader).startGoferMonitor runsc/boot/loader.go:699 +0x7f goroutine 180 [syscall, 1 minutes]: syscall.Syscall6(0x10f, 0xc0000e4708, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0) src/syscall/asm_linux_amd64.s:41 +0x5 golang.org/x/sys/unix.ppoll(0xc0000e4708, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0) external/org_golang_x_sys/unix/zsyscall_linux.go:87 +0xa2 golang.org/x/sys/unix.Ppoll(0xc0000e4708, 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(0xc000262100, 0xc0002deba0) pkg/p9/client.go:252 +0xe0 created by gvisor.dev/gvisor/pkg/p9.NewClient pkg/p9/client.go:232 +0x75e goroutine 181 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00053c1b0) 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 182 [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 5 [select, 1 minutes]: reflect.rselect(0xc000536480, 0x22, 0x22, 0xc000536480, 0x1be07d8) GOROOT/src/runtime/select.go:544 +0x3bd reflect.Select(0xc0004b6000, 0x22, 0x49, 0x20, 0x21, 0xc0004b6000, 0x20, 0x49) GOROOT/src/reflect/value.go:2229 +0x1f0 gvisor.dev/gvisor/pkg/sentry/sighandling.handleSignals(0xc00042c000, 0x21, 0x40, 0xc00053bdc0, 0xc000659080, 0xc0006590e0) pkg/sentry/sighandling/sighandling.go:44 +0x4a1 created by gvisor.dev/gvisor/pkg/sentry/sighandling.StartSignalForwarding pkg/sentry/sighandling/sighandling.go:96 +0x288 goroutine 6 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/watchdog.(*Watchdog).loop(0xc000596000) 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 7 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000228360) 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 8 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0002ae000, 0xc000659020, 0x0, 0x46d22c, 0xc00058cc80) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0002ae000, 0xc000659020, 0x1485b00, 0x0, 0x5489888, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0002ae000, 0x0, 0xc0002ae001, 0x5489888, 0x3bb700, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0002ae000, 0x5489888, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003bb7e8, 0x44006f, 0xc00004e000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0002ae000, 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(0xc0002ae000, 0xca, 0x5489888, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc0002ae8af) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0002ae000, 0xca, 0x5489888, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003bbcd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0002ae000, 0x2, 0xc0003be000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0002ae000, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0002ae000, 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 150 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000158000) 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 151 [chan receive, locked to thread]: gvisor.dev/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc00014a1a0, 0xc0001560c0, 0xc000156120) 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 187 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00053c510) 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 [semacquire, 1 minutes]: sync.runtime_Semacquire(0xc000640eb8) GOROOT/src/runtime/sema.go:56 +0x42 sync.(*WaitGroup).Wait(0xc000640eb0) 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(0xc000548160, 0xc000640800, 0x25) runsc/boot/loader.go:893 +0x43 gvisor.dev/gvisor/runsc/boot.(*Loader).waitContainer(0xc000548160, 0xc00054a330, 0x25, 0xc00056eb50, 0x0, 0xc000578588) runsc/boot/loader.go:848 +0x1af gvisor.dev/gvisor/runsc/boot.(*containerManager).Wait(0xc000500880, 0xc000367be0, 0xc00056eb50, 0x0, 0x0) runsc/boot/controller.go:430 +0xb9 reflect.Value.call(0xc000578540, 0xc00051e180, 0x13, 0x12ea670, 0x4, 0xc0002a9e60, 0x3, 0x3, 0x149d601, 0xc00056eb50, ...) GOROOT/src/reflect/value.go:460 +0x967 reflect.Value.Call(0xc000578540, 0xc00051e180, 0x13, 0xc0002a9e60, 0x3, 0x3, 0x0, 0xc000500880, 0x16) GOROOT/src/reflect/value.go:321 +0xd4 gvisor.dev/gvisor/pkg/urpc.(*Server).handleOne(0xc00051cbd0, 0xc0003bc0c0, 0x0, 0x0) pkg/urpc/urpc.go:325 +0x688 gvisor.dev/gvisor/pkg/urpc.(*Server).handleRegistered(0xc00051cbd0, 0xc0003bc0c0, 0x100000001, 0xc00054c180) pkg/urpc/urpc.go:420 +0x43 gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc00051cbd0, 0xc0003bc0c0) pkg/urpc/urpc.go:440 +0x90 created by gvisor.dev/gvisor/pkg/urpc.(*Server).StartHandling pkg/urpc/urpc.go:438 +0x6f goroutine 169 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0003fe000, 0xc0003c01e0, 0xc000156240, 0x0, 0x0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc0003fe000, 0xc0003c01e0, 0xc0003fe901, 0x2185a46c9d, 0xc00058da18, 0x10) pkg/sentry/kernel/task_block.go:80 +0xda gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0003fe000, 0xc0003c01e0, 0x1485b01, 0xdf8475800, 0x5488ad0, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:42 +0x11d gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0003fe000, 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(0xc0003fe000, 0x5488ad0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc0003cf7e8, 0x44006f, 0xc000041800, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0003fe000, 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(0xc0003fe000, 0xca, 0x5488ad0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x4078ff, 0xc0003fe8af) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0003fe000, 0xca, 0x5488ad0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc0003cfcd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0003fe000, 0x2, 0xc0003be000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0003fe000, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0003fe000, 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 152 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000158090) 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, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0003fea80, 0xc0003c03c0, 0x0, 0x46d22c, 0xc00058e420) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0003fea80, 0xc0003c03c0, 0x1485b00, 0x0, 0x54a7c00, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0003fea80, 0x0, 0xc0003fea01, 0x54a7c00, 0x100, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0003fea80, 0x54a7c00, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003b77e8, 0x44006f, 0xc00003f000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0003fea80, 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(0xc0003fea80, 0xca, 0x54a7c00, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc0003ff32f) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0003fea80, 0xca, 0x54a7c00, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003b7cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0003fea80, 0x2, 0xc0003be000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0003fea80, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0003fea80, 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 184 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00053c360) 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 185 [select]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0002af500, 0xc000659500, 0xc0003c0420, 0x0, 0x0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc0002af500, 0xc000659500, 0xc0002afe01, 0x152fbff4c9, 0xc00058e798, 0x10) pkg/sentry/kernel/task_block.go:80 +0xda gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0002af500, 0xc000659500, 0x1485b01, 0x253faec32, 0x548cd00, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:42 +0x11d gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0002af500, 0x253faec32, 0x0, 0x548cd00, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0002af500, 0x548cd00, 0x0, 0x0, 0xc4204e6ed8, 0x0, 0x0, 0xc0005cb7e8, 0x44006f, 0xc00003a000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0002af500, 0xca, 0x548cd00, 0x0, 0x0, 0xc4204e6ed8, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0002af500, 0xca, 0x548cd00, 0x0, 0x0, 0xc4204e6ed8, 0x0, 0x0, 0x4078ff, 0xc0002afdaf) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0002af500, 0xca, 0x548cd00, 0x0, 0x0, 0xc4204e6ed8, 0x0, 0x0, 0xc0005cbcd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0002af500, 0x2, 0xc0003be000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0002af500, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0002af500, 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(0xc000404000) 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(0xc0003ff500, 0xc0003c0720, 0xc000659560, 0x0, 0x0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc0003ff500, 0xc0003c0720, 0xc0003ffe01, 0x13c8bb6e3c, 0xc000588d98, 0x10) pkg/sentry/kernel/task_block.go:80 +0xda gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0003ff500, 0xc0003c0720, 0x1485b01, 0x3b836902, 0x548ce00, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:42 +0x11d gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0003ff500, 0x3b836902, 0x0, 0x548ce00, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0003ff500, 0x548ce00, 0x0, 0x0, 0xc4204e76d8, 0x0, 0x0, 0xc0005c77e8, 0x44006f, 0xc00003f000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0003ff500, 0xca, 0x548ce00, 0x0, 0x0, 0xc4204e76d8, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0003ff500, 0xca, 0x548ce00, 0x0, 0x0, 0xc4204e76d8, 0x0, 0x0, 0x4078ff, 0xc0003ffdaf) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0003ff500, 0xca, 0x548ce00, 0x0, 0x0, 0xc4204e76d8, 0x0, 0x0, 0xc0005c7cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0003ff500, 0x2, 0xc0003be000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0003ff500, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0003ff500, 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 186 [select]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00053c3f0) 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 144 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004c8000, 0xc0006582a0, 0x0, 0x46d22c, 0xc00058ab80) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004c8000, 0xc0006582a0, 0x1485b00, 0x0, 0xc4200cad48, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004c8000, 0x0, 0xc0004c8001, 0xc4200cad48, 0x4c8000, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004c8000, 0xc4200cad48, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0002a77e8, 0x44006f, 0xc00004e000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004c8000, 0xca, 0xc4200cad48, 0x0, 0x0, 0x0, 0x0, 0x0, 0x85, 0x340, ...) pkg/sentry/kernel/task_syscall.go:170 +0x44e gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0004c8000, 0xca, 0xc4200cad48, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4078ff, 0xc0004c88af) pkg/sentry/kernel/task_syscall.go:291 +0xb5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0004c8000, 0xca, 0xc4200cad48, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0002a7cd0, 0xe37486) pkg/sentry/kernel/task_syscall.go:252 +0x10a gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0004c8000, 0x2, 0xc0003be000) pkg/sentry/kernel/task_syscall.go:227 +0x1b4 gvisor.dev/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0004c8000, 0x1475d60, 0x0) pkg/sentry/kernel/task_run.go:258 +0x16a5 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).run(0xc0004c8000, 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 goroutine 194 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00053c2d0) 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 145 [select, 1 minutes]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004c8a80, 0xc000658540, 0x0, 0x46d22c, 0xc00058d5e0) pkg/sentry/kernel/task_block.go:138 +0x1db gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004c8a80, 0xc000658540, 0x1485b00, 0x0, 0xc42018e148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:37 +0x2f4 gvisor.dev/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004c8a80, 0x0, 0xc0004c8a01, 0xc42018e148, 0x4c8a00, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13a gvisor.dev/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004c8a80, 0xc42018e148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0003d17e8, 0x44006f, 0xc000049000, ...) pkg/sentry/syscalls/linux/sys_futex.go:206 +0x125 gvisor.dev/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004c8a80, 0xca, 0xc42018e148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x85, 0x340, ...) W0327 13:44:33.107286 65302 sandbox.go:750] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-2" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D0327 13:44:33.107594 65302 container.go:714] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:33.107809 65302 container.go:801] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:33.107910 65302 sandbox.go:1126] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-2" by destroying sandbox D0327 13:44:33.108028 65302 sandbox.go:796] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:33.108101 65302 container.go:815] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 65311 I0327 13:44:33.209040 65302 main.go:329] Exiting with status: 512 VM DIAGNOSIS: I0327 13:44:32.990853 3088 main.go:305] *************************** I0327 13:44:32.990991 3088 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-2] I0327 13:44:32.991165 3088 main.go:307] Version release-20200219.0-252-g76a7ace751bf I0327 13:44:32.991284 3088 main.go:308] PID: 3088 I0327 13:44:32.991365 3088 main.go:309] UID: 0, GID: 0 I0327 13:44:32.991455 3088 main.go:310] Configuration: I0327 13:44:32.991516 3088 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0327 13:44:32.991612 3088 main.go:312] Platform: ptrace I0327 13:44:32.991682 3088 main.go:313] FileAccess: shared, overlay: false I0327 13:44:32.991768 3088 main.go:314] Network: sandbox, logging: false I0327 13:44:32.991853 3088 main.go:315] Strace: false, max size: 1024, syscalls: [] I0327 13:44:32.991914 3088 main.go:316] *************************** W0327 13:44:32.992024 3088 main.go:321] Block the TERM signal. This is only safe in tests! D0327 13:44:32.992211 3088 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.999338 3088 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0327 13:44:32.999625 3088 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.999743 3088 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:33.000177 3088 urpc.go:534] urpc: successfully marshalled 117 bytes. I0327 13:44:33.107258 3088 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 65312 I0327 13:44:33.107405 3088 debug.go:137] Retrieving sandbox stacks D0327 13:44:33.107566 3088 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:33.107685 3088 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0327 13:44:33.107907 3088 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 65312: connection refused retrieving stacks: connecting to control server at PID 65312: connection refused W0327 13:44:33.108356 3088 main.go:338] Failure to execute command, err: 1 Error collecting stacks: failed to run ["/syzkaller/managers/ptrace-proxy-sandbox-race/current/image" "-root" "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "-watchdog-action=panic" "-network=none" "-debug" "-alsologtostderr" "-platform=ptrace" "-file-access=shared" "-network=sandbox" "-TESTONLY-unsafe-nonroot" "debug" "-stacks" "--ps" "ci-gvisor-ptrace-proxy-sandbox-race-2"]: exit status 128 I0327 13:44:32.990853 3088 main.go:305] *************************** I0327 13:44:32.990991 3088 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot debug -stacks --ps ci-gvisor-ptrace-proxy-sandbox-race-2] I0327 13:44:32.991165 3088 main.go:307] Version release-20200219.0-252-g76a7ace751bf I0327 13:44:32.991284 3088 main.go:308] PID: 3088 I0327 13:44:32.991365 3088 main.go:309] UID: 0, GID: 0 I0327 13:44:32.991455 3088 main.go:310] Configuration: I0327 13:44:32.991516 3088 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0327 13:44:32.991612 3088 main.go:312] Platform: ptrace I0327 13:44:32.991682 3088 main.go:313] FileAccess: shared, overlay: false I0327 13:44:32.991768 3088 main.go:314] Network: sandbox, logging: false I0327 13:44:32.991853 3088 main.go:315] Strace: false, max size: 1024, syscalls: [] I0327 13:44:32.991914 3088 main.go:316] *************************** W0327 13:44:32.992024 3088 main.go:321] Block the TERM signal. This is only safe in tests! D0327 13:44:32.992211 3088 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.999338 3088 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0327 13:44:32.999625 3088 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:32.999743 3088 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:33.000177 3088 urpc.go:534] urpc: successfully marshalled 117 bytes. I0327 13:44:33.107258 3088 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 65312 I0327 13:44:33.107405 3088 debug.go:137] Retrieving sandbox stacks D0327 13:44:33.107566 3088 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0327 13:44:33.107685 3088 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0327 13:44:33.107907 3088 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 65312: connection refused retrieving stacks: connecting to control server at PID 65312: connection refused W0327 13:44:33.108356 3088 main.go:338] Failure to execute command, err: 1 [303047.533509] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303047.533510] [] ? vmx_vcpu_run+0x337/0x4f0 [kvm_intel] [303047.533510] [] ? kvm_arch_vcpu_ioctl_run+0x6df/0x16d0 [kvm] [303047.533511] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303047.533513] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303047.533514] [] ? dequeue_signal+0x4b/0x180 [303047.533514] [] ? __seccomp_filter+0x74/0x270 [303047.533515] [] ? do_vfs_ioctl+0xa2/0x620 [303047.533516] [] ? __audit_syscall_entry+0xaa/0xf0 [303047.533517] [] ? syscall_trace_enter+0x1ae/0x2c0 [303047.533517] [] ? SyS_ioctl+0x74/0x80 [303047.533518] [] ? do_syscall_64+0x8d/0x100 [303047.533519] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303047.533520] 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.533522] NMI backtrace for cpu 13 [303047.533522] CPU: 13 PID: 9284 Comm: exe Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303047.533523] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [303047.533524] task: ffff9fc5a9829100 task.stack: ffffba1979e18000 [303047.533525] RIP: 0010:[] c [] vmx_complete_atomic_exit.constprop.93+0x5e/0x80 [kvm_intel] [303047.533525] RSP: 0018:ffffba1979e1bce0 EFLAGS: 00000046 [303047.533526] RAX: 0000000080000200 RBX: ffff9fc5aa8e9600 RCX: ffff9fc5aa8e9600 [303047.533527] RDX: 0000000080000202 RSI: 0000000000000000 RDI: ffff9fc5aa8e9600 [303047.533528] RBP: ffff9fc5aa8e9600 R08: 0000000000000000 R09: 0000000000000000 [303047.533528] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 [303047.533529] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 [303047.533530] FS: 000000c000f2e090(0000) GS:ffff9fca86940000(0000) knlGS:ffff80c00069f200 [303047.533531] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [303047.533532] CR2: 00007ffe84775a00 CR3: 00000013dbf30000 CR4: 0000000000162670 [303047.533533] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [303047.533534] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [303047.533534] Stack: [303047.533535] ffffffffc09cf018c 0000000000000000c ffffffffc09e0ba7c ffff9fc5aa8e9600c [303047.533536] 0000000000000000c ffff9fc5aa8e9600c ffffba1979e1bde8c 0000000000000000c [303047.533537] 0000000000231788c 0000000000000000c 0000000000000000c ffffffffc08fa25fc [303047.533537] Call Trace: [303047.533538] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [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.462