D0319 03:12:51.020145 25681 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0319 03:12:51.020375 25681 parameters.go:238] Clock(Monotonic): error: 669 ns, adjusted frequency from 2299773599 Hz to 2299775413 Hz D0319 03:12:51.020636 25681 parameters.go:238] Clock(Realtime): error: 225 ns, adjusted frequency from 2299773799 Hz to 2299774607 Hz D0319 03:12:51.020761 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239291323807756 monotonicBaseRef:2000490872 monotonicFrequency:2299775413 realtimeReady:1 realtimeBaseCycles:1239291324435537 realtimeBaseRef:1584587571020630219 realtimeFrequency:2299774607} D0319 03:12:52.020078 25681 parameters.go:238] Clock(Monotonic): error: -240 ns, adjusted frequency from 2299775413 Hz to 2299773551 Hz D0319 03:12:52.020352 25681 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0319 03:12:52.020454 25681 parameters.go:238] Clock(Realtime): error: 161 ns, adjusted frequency from 2299774607 Hz to 2299774506 Hz D0319 03:12:52.020581 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239293622911258 monotonicBaseRef:3000198708 monotonicFrequency:2299773551 realtimeReady:1 realtimeBaseCycles:1239293623794528 realtimeBaseRef:1584587572020449498 realtimeFrequency:2299774506} D0319 03:12:53.020059 25681 parameters.go:238] Clock(Monotonic): error: 415 ns, adjusted frequency from 2299773551 Hz to 2299775180 Hz D0319 03:12:53.020277 25681 parameters.go:238] Clock(Realtime): error: 557 ns, adjusted frequency from 2299774506 Hz to 2299775468 Hz D0319 03:12:53.020466 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239295922615119 monotonicBaseRef:4000168405 monotonicFrequency:2299775180 realtimeReady:1 realtimeBaseCycles:1239295923158401 realtimeBaseRef:1584587573020270944 realtimeFrequency:2299775468} D0319 03:12:54.020722 25681 parameters.go:238] Clock(Monotonic): error: 772 ns, adjusted frequency from 2299775180 Hz to 2299775993 Hz D0319 03:12:54.020970 25681 parameters.go:238] Clock(Realtime): error: 106 ns, adjusted frequency from 2299775468 Hz to 2299774491 Hz D0319 03:12:54.021092 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239298223912127 monotonicBaseRef:5000830134 monotonicFrequency:2299775993 realtimeReady:1 realtimeBaseCycles:1239298224526418 realtimeBaseRef:1584587574020963424 realtimeFrequency:2299774491} D0319 03:12:55.020125 25681 parameters.go:238] Clock(Monotonic): error: -550 ns, adjusted frequency from 2299775993 Hz to 2299773039 Hz D0319 03:12:55.020315 25681 parameters.go:238] Clock(Realtime): error: 6 ns, adjusted frequency from 2299774491 Hz to 2299774185 Hz D0319 03:12:55.020438 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239300522337405 monotonicBaseRef:6000242809 monotonicFrequency:2299773039 realtimeReady:1 realtimeBaseCycles:1239300522798362 realtimeBaseRef:1584587575020310078 realtimeFrequency:2299774185} D0319 03:12:56.020035 25681 parameters.go:238] Clock(Monotonic): error: 13 ns, adjusted frequency from 2299773039 Hz to 2299774322 Hz D0319 03:12:56.020241 25681 parameters.go:238] Clock(Realtime): error: 62 ns, adjusted frequency from 2299774185 Hz to 2299774415 Hz D0319 03:12:56.020390 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239302821889271 monotonicBaseRef:7000146637 monotonicFrequency:2299774322 realtimeReady:1 realtimeBaseCycles:1239302822399397 realtimeBaseRef:1584587576020234787 realtimeFrequency:2299774415} D0319 03:12:57.020143 25681 parameters.go:238] Clock(Monotonic): error: 493 ns, adjusted frequency from 2299774322 Hz to 2299775395 Hz D0319 03:12:57.020346 25681 parameters.go:238] Clock(Realtime): error: 125 ns, adjusted frequency from 2299774415 Hz to 2299774585 Hz D0319 03:12:57.020477 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239305121904067 monotonicBaseRef:8000251201 monotonicFrequency:2299775395 realtimeReady:1 realtimeBaseCycles:1239305122412338 realtimeBaseRef:1584587577020338504 realtimeFrequency:2299774585} D0319 03:12:58.020147 25681 parameters.go:238] Clock(Monotonic): error: -53 ns, adjusted frequency from 2299775395 Hz to 2299774145 Hz D0319 03:12:58.020354 25681 parameters.go:238] Clock(Realtime): error: -21 ns, adjusted frequency from 2299774585 Hz to 2299774276 Hz D0319 03:12:58.020472 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239307421707878 monotonicBaseRef:9000263556 monotonicFrequency:2299774145 realtimeReady:1 realtimeBaseCycles:1239307422207815 realtimeBaseRef:1584587578020347588 realtimeFrequency:2299774276} D0319 03:12:59.020106 25681 parameters.go:238] Clock(Monotonic): error: -155 ns, adjusted frequency from 2299774145 Hz to 2299773975 Hz D0319 03:12:59.020303 25681 parameters.go:238] Clock(Realtime): error: -53 ns, adjusted frequency from 2299774276 Hz to 2299774247 Hz D0319 03:12:59.020419 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239309721397622 monotonicBaseRef:10000226856 monotonicFrequency:2299773975 realtimeReady:1 realtimeBaseCycles:1239309721866105 realtimeBaseRef:1584587579020297154 realtimeFrequency:2299774247} D0319 03:13:00.020114 25681 parameters.go:238] Clock(Monotonic): error: 145 ns, adjusted frequency from 2299773975 Hz to 2299774700 Hz D0319 03:13:00.020301 25681 parameters.go:238] Clock(Realtime): error: 28 ns, adjusted frequency from 2299774247 Hz to 2299774444 Hz D0319 03:13:00.020407 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239312021182389 monotonicBaseRef:11000231548 monotonicFrequency:2299774700 realtimeReady:1 realtimeBaseCycles:1239312021638381 realtimeBaseRef:1584587580020296296 realtimeFrequency:2299774444} D0319 03:13:01.020134 25681 parameters.go:238] Clock(Monotonic): error: -261 ns, adjusted frequency from 2299774700 Hz to 2299773830 Hz D0319 03:13:01.020335 25681 parameters.go:238] Clock(Realtime): error: -61 ns, adjusted frequency from 2299774444 Hz to 2299774262 Hz D0319 03:13:01.020455 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239314320986296 monotonicBaseRef:12000244247 monotonicFrequency:2299773830 realtimeReady:1 realtimeBaseCycles:1239314321490929 realtimeBaseRef:1584587581020330257 realtimeFrequency:2299774262} D0319 03:13:02.020118 25681 parameters.go:238] Clock(Monotonic): error: 431 ns, adjusted frequency from 2299773830 Hz to 2299775320 Hz D0319 03:13:02.020466 25681 parameters.go:238] Clock(Realtime): error: 265 ns, adjusted frequency from 2299774262 Hz to 2299774984 Hz D0319 03:13:02.020672 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239316620740906 monotonicBaseRef:13000235889 monotonicFrequency:2299775320 realtimeReady:1 realtimeBaseCycles:1239316621554669 realtimeBaseRef:1584587582020456129 realtimeFrequency:2299774984} D0319 03:13:03.020423 25681 parameters.go:238] Clock(Monotonic): error: 103 ns, adjusted frequency from 2299775320 Hz to 2299774616 Hz D0319 03:13:03.020681 25681 parameters.go:238] Clock(Realtime): error: -107 ns, adjusted frequency from 2299774984 Hz to 2299774147 Hz D0319 03:13:03.020863 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239318921216531 monotonicBaseRef:14000540399 monotonicFrequency:2299774616 realtimeReady:1 realtimeBaseCycles:1239318921829122 realtimeBaseRef:1584587583020673310 realtimeFrequency:2299774147} D0319 03:13:04.020490 25681 parameters.go:238] Clock(Monotonic): error: -455 ns, adjusted frequency from 2299774616 Hz to 2299773352 Hz D0319 03:13:04.020757 25681 parameters.go:238] Clock(Realtime): error: 62 ns, adjusted frequency from 2299774147 Hz to 2299774578 Hz D0319 03:13:04.020950 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239321221147635 monotonicBaseRef:15000608443 monotonicFrequency:2299773352 realtimeReady:1 realtimeBaseCycles:1239321221778989 realtimeBaseRef:1584587584020749717 realtimeFrequency:2299774578} D0319 03:13:05.020147 25681 parameters.go:238] Clock(Monotonic): error: 419 ns, adjusted frequency from 2299773352 Hz to 2299775306 Hz D0319 03:13:05.020399 25681 parameters.go:238] Clock(Realtime): error: 59 ns, adjusted frequency from 2299774578 Hz to 2299774554 Hz D0319 03:13:05.020587 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239323520083230 monotonicBaseRef:16000244164 monotonicFrequency:2299775306 realtimeReady:1 realtimeBaseCycles:1239323520731449 realtimeBaseRef:1584587585020392239 realtimeFrequency:2299774554} D0319 03:13:06.020198 25681 parameters.go:238] Clock(Monotonic): error: -5 ns, adjusted frequency from 2299775306 Hz to 2299774369 Hz D0319 03:13:06.020440 25681 parameters.go:238] Clock(Realtime): error: 28 ns, adjusted frequency from 2299774554 Hz to 2299774479 Hz D0319 03:13:06.020627 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239325819971238 monotonicBaseRef:17000293169 monotonicFrequency:2299774369 realtimeReady:1 realtimeBaseCycles:1239325820604101 realtimeBaseRef:1584587586020434894 realtimeFrequency:2299774479} D0319 03:13:07.020126 25681 parameters.go:238] Clock(Monotonic): error: 21 ns, adjusted frequency from 2299774369 Hz to 2299774421 Hz D0319 03:13:07.020329 25681 parameters.go:238] Clock(Realtime): error: 0 ns, adjusted frequency from 2299774479 Hz to 2299774392 Hz D0319 03:13:07.020454 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239328119630485 monotonicBaseRef:18000243111 monotonicFrequency:2299774421 realtimeReady:1 realtimeBaseCycles:1239328120121935 realtimeBaseRef:1584587587020323298 realtimeFrequency:2299774392} D0319 03:13:08.020095 25681 parameters.go:238] Clock(Monotonic): error: 4 ns, adjusted frequency from 2299774421 Hz to 2299774424 Hz D0319 03:13:08.020329 25681 parameters.go:238] Clock(Realtime): error: 29 ns, adjusted frequency from 2299774392 Hz to 2299774485 Hz D0319 03:13:08.020479 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239330419317709 monotonicBaseRef:19000205195 monotonicFrequency:2299774424 realtimeReady:1 realtimeBaseCycles:1239330419894554 realtimeBaseRef:1584587588020322527 realtimeFrequency:2299774485} D0319 03:13:09.020601 25681 parameters.go:238] Clock(Monotonic): error: -85 ns, adjusted frequency from 2299774424 Hz to 2299774241 Hz D0319 03:13:09.020776 25681 parameters.go:238] Clock(Realtime): error: -248 ns, adjusted frequency from 2299774485 Hz to 2299773850 Hz D0319 03:13:09.020910 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239332720275942 monotonicBaseRef:20000719945 monotonicFrequency:2299774241 realtimeReady:1 realtimeBaseCycles:1239332720698629 realtimeBaseRef:1584587589020770218 realtimeFrequency:2299773850} D0319 03:13:10.020629 25681 parameters.go:238] Clock(Monotonic): error: -27 ns, adjusted frequency from 2299774241 Hz to 2299774271 Hz D0319 03:13:10.020806 25681 parameters.go:238] Clock(Realtime): error: 171 ns, adjusted frequency from 2299773850 Hz to 2299774784 Hz D0319 03:13:10.020918 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239335020111329 monotonicBaseRef:21000746532 monotonicFrequency:2299774271 realtimeReady:1 realtimeBaseCycles:1239335020542428 realtimeBaseRef:1584587590020800633 realtimeFrequency:2299774784} D0319 03:13:11.020132 25681 parameters.go:238] Clock(Monotonic): error: 86 ns, adjusted frequency from 2299774271 Hz to 2299774622 Hz D0319 03:13:11.020316 25681 parameters.go:238] Clock(Realtime): error: -252 ns, adjusted frequency from 2299774784 Hz to 2299773874 Hz D0319 03:13:11.020428 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239337318743273 monotonicBaseRef:22000249819 monotonicFrequency:2299774622 realtimeReady:1 realtimeBaseCycles:1239337319191543 realtimeBaseRef:1584587591020311163 realtimeFrequency:2299773874} D0319 03:13:12.020172 25681 parameters.go:238] Clock(Monotonic): error: -324 ns, adjusted frequency from 2299774622 Hz to 2299773729 Hz D0319 03:13:12.020425 25681 parameters.go:238] Clock(Realtime): error: 193 ns, adjusted frequency from 2299773874 Hz to 2299774844 Hz D0319 03:13:12.020574 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239339618601936 monotonicBaseRef:23000286362 monotonicFrequency:2299773729 realtimeReady:1 realtimeBaseCycles:1239339619209532 realtimeBaseRef:1584587592020417310 realtimeFrequency:2299774844} D0319 03:13:13.020180 25681 parameters.go:238] Clock(Monotonic): error: -69 ns, adjusted frequency from 2299773729 Hz to 2299774254 Hz D0319 03:13:13.020457 25681 parameters.go:238] Clock(Realtime): error: 127 ns, adjusted frequency from 2299774844 Hz to 2299774741 Hz D0319 03:13:13.020606 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239341918355883 monotonicBaseRef:24000277760 monotonicFrequency:2299774254 realtimeReady:1 realtimeBaseCycles:1239341919061208 realtimeBaseRef:1584587593020450718 realtimeFrequency:2299774741} D0319 03:13:14.020148 25681 parameters.go:238] Clock(Monotonic): error: 102 ns, adjusted frequency from 2299774254 Hz to 2299774733 Hz D0319 03:13:14.020443 25681 parameters.go:238] Clock(Realtime): error: -280 ns, adjusted frequency from 2299774741 Hz to 2299773821 Hz D0319 03:13:14.020663 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239344218098741 monotonicBaseRef:25000264108 monotonicFrequency:2299774733 realtimeReady:1 realtimeBaseCycles:1239344218794800 realtimeBaseRef:1584587594020432825 realtimeFrequency:2299773821} D0319 03:13:15.020173 25681 parameters.go:238] Clock(Monotonic): error: 108 ns, adjusted frequency from 2299774733 Hz to 2299774627 Hz D0319 03:13:15.020446 25681 parameters.go:238] Clock(Realtime): error: 220 ns, adjusted frequency from 2299773821 Hz to 2299774916 Hz D0319 03:13:15.020618 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239346517921709 monotonicBaseRef:26000285081 monotonicFrequency:2299774627 realtimeReady:1 realtimeBaseCycles:1239346518581013 realtimeBaseRef:1584587595020438213 realtimeFrequency:2299774916} D0319 03:13:16.020133 25681 parameters.go:238] Clock(Monotonic): error: -148 ns, adjusted frequency from 2299774627 Hz to 2299774171 Hz D0319 03:13:16.020366 25681 parameters.go:238] Clock(Realtime): error: -103 ns, adjusted frequency from 2299774916 Hz to 2299774139 Hz D0319 03:13:16.020582 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239348817600676 monotonicBaseRef:27000243485 monotonicFrequency:2299774171 realtimeReady:1 realtimeBaseCycles:1239348818174746 realtimeBaseRef:1584587596020359430 realtimeFrequency:2299774139} D0319 03:13:17.024737 25681 parameters.go:238] Clock(Monotonic): error: -84 ns, adjusted frequency from 2299774171 Hz to 2299774305 Hz D0319 03:13:17.025050 25681 parameters.go:238] Clock(Realtime): error: 213 ns, adjusted frequency from 2299774139 Hz to 2299774848 Hz D0319 03:13:17.025183 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239351127965199 monotonicBaseRef:28004848438 monotonicFrequency:2299774305 realtimeReady:1 realtimeBaseCycles:1239351128702608 realtimeBaseRef:1584587597025035420 realtimeFrequency:2299774848} D0319 03:13:18.020726 25681 parameters.go:238] Clock(Monotonic): error: 263 ns, adjusted frequency from 2299774305 Hz to 2299774989 Hz D0319 03:13:18.020955 25681 parameters.go:238] Clock(Realtime): error: -282 ns, adjusted frequency from 2299774848 Hz to 2299773772 Hz D0319 03:13:18.021089 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239353418523521 monotonicBaseRef:29000841095 monotonicFrequency:2299774989 realtimeReady:1 realtimeBaseCycles:1239353419082587 realtimeBaseRef:1584587598020950294 realtimeFrequency:2299773772} D0319 03:13:19.020780 25681 parameters.go:238] Clock(Monotonic): error: 83 ns, adjusted frequency from 2299774989 Hz to 2299774577 Hz D0319 03:13:19.020994 25681 parameters.go:238] Clock(Realtime): error: 9 ns, adjusted frequency from 2299773772 Hz to 2299774468 Hz D0319 03:13:19.021109 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239355718422126 monotonicBaseRef:30000894846 monotonicFrequency:2299774577 realtimeReady:1 realtimeBaseCycles:1239355718943473 realtimeBaseRef:1584587599020988173 realtimeFrequency:2299774468} D0319 03:13:20.021565 25681 parameters.go:238] Clock(Monotonic): error: -384 ns, adjusted frequency from 2299774577 Hz to 2299773607 Hz D0319 03:13:20.021799 25681 parameters.go:238] Clock(Realtime): error: 115 ns, adjusted frequency from 2299774468 Hz to 2299774614 Hz D0319 03:13:20.021943 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239358019995459 monotonicBaseRef:31001676990 monotonicFrequency:2299773607 realtimeReady:1 realtimeBaseCycles:1239358020568666 realtimeBaseRef:1584587600021792914 realtimeFrequency:2299774614} D0319 03:13:20.262307 25681 urpc.go:577] urpc: unmarshal success. D0319 03:13:20.262628 25681 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0319 03:13:20.264625 25681 urpc.go:534] urpc: successfully marshalled 37 bytes. D0319 03:13:21.021522 25681 parameters.go:238] Clock(Monotonic): error: 477 ns, adjusted frequency from 2299773607 Hz to 2299775431 Hz D0319 03:13:21.021789 25681 parameters.go:238] Clock(Realtime): error: 189 ns, adjusted frequency from 2299774614 Hz to 2299774824 Hz D0319 03:13:21.021916 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239360319681291 monotonicBaseRef:32001638823 monotonicFrequency:2299775431 realtimeReady:1 realtimeBaseCycles:1239360320319221 realtimeBaseRef:1584587601021782452 realtimeFrequency:2299774824} D0319 03:13:22.020119 25681 parameters.go:238] Clock(Monotonic): error: -153 ns, adjusted frequency from 2299775431 Hz to 2299773974 Hz D0319 03:13:22.021417 25681 parameters.go:238] Clock(Realtime): error: -304 ns, adjusted frequency from 2299774824 Hz to 2299773708 Hz D0319 03:13:22.021521 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239362616224289 monotonicBaseRef:33000233280 monotonicFrequency:2299773974 realtimeReady:1 realtimeBaseCycles:1239362619222528 realtimeBaseRef:1584587602021403494 realtimeFrequency:2299773708} D0319 03:13:23.020140 25681 parameters.go:238] Clock(Monotonic): error: -351 ns, adjusted frequency from 2299773974 Hz to 2299773606 Hz D0319 03:13:23.020330 25681 parameters.go:238] Clock(Realtime): error: 63 ns, adjusted frequency from 2299773708 Hz to 2299774526 Hz D0319 03:13:23.020420 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239364916047477 monotonicBaseRef:34000254679 monotonicFrequency:2299773606 realtimeReady:1 realtimeBaseCycles:1239364916516169 realtimeBaseRef:1584587603020325097 realtimeFrequency:2299774526} D0319 03:13:24.020128 25681 parameters.go:238] Clock(Monotonic): error: 395 ns, adjusted frequency from 2299773606 Hz to 2299775360 Hz D0319 03:13:24.020339 25681 parameters.go:238] Clock(Realtime): error: -5 ns, adjusted frequency from 2299774526 Hz to 2299774409 Hz D0319 03:13:24.020434 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239367215795275 monotonicBaseRef:35000243457 monotonicFrequency:2299775360 realtimeReady:1 realtimeBaseCycles:1239367216310898 realtimeBaseRef:1584587604020333881 realtimeFrequency:2299774409} D0319 03:13:25.020168 25681 parameters.go:238] Clock(Monotonic): error: 39 ns, adjusted frequency from 2299775360 Hz to 2299774449 Hz D0319 03:13:25.020394 25681 parameters.go:238] Clock(Realtime): error: -112 ns, adjusted frequency from 2299774409 Hz to 2299774198 Hz D0319 03:13:25.020527 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239369515616219 monotonicBaseRef:36000263278 monotonicFrequency:2299774449 realtimeReady:1 realtimeBaseCycles:1239369516210456 realtimeBaseRef:1584587605020388298 realtimeFrequency:2299774198} D0319 03:13:26.020125 25681 parameters.go:238] Clock(Monotonic): error: -20 ns, adjusted frequency from 2299774449 Hz to 2299774314 Hz D0319 03:13:26.020394 25681 parameters.go:238] Clock(Realtime): error: 146 ns, adjusted frequency from 2299774198 Hz to 2299774829 Hz D0319 03:13:26.020505 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239371815333747 monotonicBaseRef:37000238527 monotonicFrequency:2299774314 realtimeReady:1 realtimeBaseCycles:1239371815975552 realtimeBaseRef:1584587606020384340 realtimeFrequency:2299774829} D0319 03:13:27.020210 25681 parameters.go:238] Clock(Monotonic): error: -262 ns, adjusted frequency from 2299774314 Hz to 2299773915 Hz D0319 03:13:27.020445 25681 parameters.go:238] Clock(Realtime): error: 73 ns, adjusted frequency from 2299774829 Hz to 2299774564 Hz D0319 03:13:27.020651 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239374115305805 monotonicBaseRef:38000324511 monotonicFrequency:2299773915 realtimeReady:1 realtimeBaseCycles:1239374115875912 realtimeBaseRef:1584587607020438924 realtimeFrequency:2299774564} D0319 03:13:28.020926 25681 parameters.go:238] Clock(Monotonic): error: 308 ns, adjusted frequency from 2299773915 Hz to 2299775132 Hz D0319 03:13:28.021222 25681 parameters.go:238] Clock(Realtime): error: 66 ns, adjusted frequency from 2299774564 Hz to 2299774536 Hz D0319 03:13:28.021387 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239376414962271 monotonicBaseRef:39000273441 monotonicFrequency:2299775132 realtimeReady:1 realtimeBaseCycles:1239376417432809 realtimeBaseRef:1584587608021213927 realtimeFrequency:2299774536} D0319 03:13:29.020155 25681 parameters.go:238] Clock(Monotonic): error: -155 ns, adjusted frequency from 2299775132 Hz to 2299773921 Hz D0319 03:13:29.021993 25681 parameters.go:238] Clock(Realtime): error: -115 ns, adjusted frequency from 2299774536 Hz to 2299774208 Hz D0319 03:13:29.022140 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239378714729378 monotonicBaseRef:40000269951 monotonicFrequency:2299773921 realtimeReady:1 realtimeBaseCycles:1239378718976144 realtimeBaseRef:1584587609021983045 realtimeFrequency:2299774208} D0319 03:13:30.020382 25681 parameters.go:238] Clock(Monotonic): error: -181 ns, adjusted frequency from 2299773921 Hz to 2299774071 Hz D0319 03:13:30.020693 25681 parameters.go:238] Clock(Realtime): error: 118 ns, adjusted frequency from 2299774208 Hz to 2299774698 Hz D0319 03:13:30.020856 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239381014914146 monotonicBaseRef:41000448597 monotonicFrequency:2299774071 realtimeReady:1 realtimeBaseCycles:1239381015764989 realtimeBaseRef:1584587610020684933 realtimeFrequency:2299774698} D0319 03:13:31.020121 25681 parameters.go:238] Clock(Monotonic): error: 599 ns, adjusted frequency from 2299774071 Hz to 2299775852 Hz D0319 03:13:31.020335 25681 parameters.go:238] Clock(Realtime): error: -267 ns, adjusted frequency from 2299774698 Hz to 2299773806 Hz D0319 03:13:31.021881 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239383314164919 monotonicBaseRef:42000221053 monotonicFrequency:2299775852 realtimeReady:1 realtimeBaseCycles:1239383314723870 realtimeBaseRef:1584587611020330195 realtimeFrequency:2299773806} D0319 03:13:32.020153 25681 parameters.go:238] Clock(Monotonic): error: -577 ns, adjusted frequency from 2299775852 Hz to 2299773092 Hz D0319 03:13:32.020388 25681 parameters.go:238] Clock(Realtime): error: 284 ns, adjusted frequency from 2299773806 Hz to 2299775062 Hz D0319 03:13:32.020577 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239385614045763 monotonicBaseRef:43000266706 monotonicFrequency:2299773092 realtimeReady:1 realtimeBaseCycles:1239385614613570 realtimeBaseRef:1584587612020380588 realtimeFrequency:2299775062} D0319 03:13:33.020143 25681 parameters.go:238] Clock(Monotonic): error: -32 ns, adjusted frequency from 2299773092 Hz to 2299774443 Hz D0319 03:13:33.020408 25681 parameters.go:238] Clock(Realtime): error: -140 ns, adjusted frequency from 2299775062 Hz to 2299774079 Hz D0319 03:13:33.020548 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239387913795970 monotonicBaseRef:44000256755 monotonicFrequency:2299774443 realtimeReady:1 realtimeBaseCycles:1239387914433972 realtimeBaseRef:1584587613020400302 realtimeFrequency:2299774079} D0319 03:13:34.020165 25681 parameters.go:238] Clock(Monotonic): error: -48 ns, adjusted frequency from 2299774443 Hz to 2299774359 Hz D0319 03:13:34.020497 25681 parameters.go:238] Clock(Realtime): error: -266 ns, adjusted frequency from 2299774079 Hz to 2299773831 Hz D0319 03:13:34.020658 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239390213617984 monotonicBaseRef:45000277440 monotonicFrequency:2299774359 realtimeReady:1 realtimeBaseCycles:1239390214416325 realtimeBaseRef:1584587614020490864 realtimeFrequency:2299773831} I0319 03:13:34.196502 25681 watchdog.go:277] Watchdog starting loop, tasks: 14, discount: 0s D0319 03:13:35.020177 25681 parameters.go:238] Clock(Monotonic): error: 83 ns, adjusted frequency from 2299774359 Hz to 2299774568 Hz D0319 03:13:35.020391 25681 parameters.go:238] Clock(Realtime): error: 176 ns, adjusted frequency from 2299773831 Hz to 2299774819 Hz D0319 03:13:35.020483 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239392513398680 monotonicBaseRef:46000280195 monotonicFrequency:2299774568 realtimeReady:1 realtimeBaseCycles:1239392513949034 realtimeBaseRef:1584587615020386018 realtimeFrequency:2299774819} D0319 03:13:36.020180 25681 parameters.go:238] Clock(Monotonic): error: 155 ns, adjusted frequency from 2299774568 Hz to 2299774639 Hz D0319 03:13:36.020404 25681 parameters.go:238] Clock(Realtime): error: -42 ns, adjusted frequency from 2299774819 Hz to 2299774331 Hz D0319 03:13:36.020510 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239394813207930 monotonicBaseRef:47000295275 monotonicFrequency:2299774639 realtimeReady:1 realtimeBaseCycles:1239394813754712 realtimeBaseRef:1584587616020399436 realtimeFrequency:2299774331} D0319 03:13:37.020157 25681 parameters.go:238] Clock(Monotonic): error: -131 ns, adjusted frequency from 2299774639 Hz to 2299774228 Hz D0319 03:13:37.020476 25681 parameters.go:238] Clock(Realtime): error: 2 ns, adjusted frequency from 2299774331 Hz to 2299774505 Hz D0319 03:13:37.020695 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239397112924747 monotonicBaseRef:48000270132 monotonicFrequency:2299774228 realtimeReady:1 realtimeBaseCycles:1239397113685434 realtimeBaseRef:1584587617020467438 realtimeFrequency:2299774505} D0319 03:13:38.020148 25681 parameters.go:238] Clock(Monotonic): error: -47 ns, adjusted frequency from 2299774228 Hz to 2299774445 Hz D0319 03:13:38.020405 25681 parameters.go:238] Clock(Realtime): error: 137 ns, adjusted frequency from 2299774505 Hz to 2299774729 Hz D0319 03:13:38.020542 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239399412681697 monotonicBaseRef:49000262619 monotonicFrequency:2299774445 realtimeReady:1 realtimeBaseCycles:1239399413300854 realtimeBaseRef:1584587618020398263 realtimeFrequency:2299774729} D0319 03:13:39.020844 25681 parameters.go:238] Clock(Monotonic): error: -118 ns, adjusted frequency from 2299774445 Hz to 2299774146 Hz D0319 03:13:39.021091 25681 parameters.go:238] Clock(Realtime): error: 116 ns, adjusted frequency from 2299774729 Hz to 2299774668 Hz D0319 03:13:39.021215 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239401714056806 monotonicBaseRef:50000958628 monotonicFrequency:2299774146 realtimeReady:1 realtimeBaseCycles:1239401714653559 realtimeBaseRef:1584587619021084406 realtimeFrequency:2299774668} D0319 03:13:40.021293 25681 parameters.go:238] Clock(Monotonic): error: 150 ns, adjusted frequency from 2299774146 Hz to 2299774811 Hz D0319 03:13:40.021568 25681 parameters.go:238] Clock(Realtime): error: -273 ns, adjusted frequency from 2299774668 Hz to 2299773851 Hz D0319 03:13:40.021739 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239404014860568 monotonicBaseRef:51001406331 monotonicFrequency:2299774811 realtimeReady:1 realtimeBaseCycles:1239404015519106 realtimeBaseRef:1584587620021558747 realtimeFrequency:2299773851} D0319 03:13:41.020746 25681 parameters.go:238] Clock(Monotonic): error: -209 ns, adjusted frequency from 2299774811 Hz to 2299773933 Hz D0319 03:13:41.020997 25681 parameters.go:238] Clock(Realtime): error: 155 ns, adjusted frequency from 2299773851 Hz to 2299774740 Hz D0319 03:13:41.021162 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239406313382087 monotonicBaseRef:52000861368 monotonicFrequency:2299773933 realtimeReady:1 realtimeBaseCycles:1239406313985430 realtimeBaseRef:1584587621020990201 realtimeFrequency:2299774740} D0319 03:13:42.020163 25681 parameters.go:238] Clock(Monotonic): error: 20 ns, adjusted frequency from 2299773933 Hz to 2299774440 Hz D0319 03:13:42.020444 25681 parameters.go:238] Clock(Realtime): error: 131 ns, adjusted frequency from 2299774740 Hz to 2299774696 Hz D0319 03:13:42.020659 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239408611811562 monotonicBaseRef:53000276763 monotonicFrequency:2299774440 realtimeReady:1 realtimeBaseCycles:1239408612470164 realtimeBaseRef:1584587622020429273 realtimeFrequency:2299774696} D0319 03:13:43.020579 25681 parameters.go:238] Clock(Monotonic): error: 296 ns, adjusted frequency from 2299774440 Hz to 2299774994 Hz D0319 03:13:43.020775 25681 parameters.go:238] Clock(Realtime): error: -309 ns, adjusted frequency from 2299774696 Hz to 2299773704 Hz D0319 03:13:43.020887 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239410912544403 monotonicBaseRef:54000693499 monotonicFrequency:2299774994 realtimeReady:1 realtimeBaseCycles:1239410913028678 realtimeBaseRef:1584587623020770096 realtimeFrequency:2299773704} D0319 03:13:44.020351 25681 parameters.go:238] Clock(Monotonic): error: 141 ns, adjusted frequency from 2299774994 Hz to 2299774769 Hz D0319 03:13:44.020588 25681 parameters.go:238] Clock(Realtime): error: -1 ns, adjusted frequency from 2299773704 Hz to 2299774408 Hz D0319 03:13:44.020732 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239413211780032 monotonicBaseRef:55000458969 monotonicFrequency:2299774769 realtimeReady:1 realtimeBaseCycles:1239413212370920 realtimeBaseRef:1584587624020582485 realtimeFrequency:2299774408} D0319 03:13:45.024643 25681 parameters.go:238] Clock(Monotonic): error: -27 ns, adjusted frequency from 2299774769 Hz to 2299774388 Hz D0319 03:13:45.024849 25681 parameters.go:238] Clock(Realtime): error: 45 ns, adjusted frequency from 2299774408 Hz to 2299774532 Hz D0319 03:13:45.024973 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239415521415303 monotonicBaseRef:56004746563 monotonicFrequency:2299774388 realtimeReady:1 realtimeBaseCycles:1239415521944617 realtimeBaseRef:1584587625024843463 realtimeFrequency:2299774532} D0319 03:13:46.020195 25681 parameters.go:238] Clock(Monotonic): error: -349 ns, adjusted frequency from 2299774388 Hz to 2299773583 Hz D0319 03:13:46.020451 25681 parameters.go:238] Clock(Realtime): error: 91 ns, adjusted frequency from 2299774532 Hz to 2299774555 Hz D0319 03:13:46.020593 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239417810986683 monotonicBaseRef:57000310037 monotonicFrequency:2299773583 realtimeReady:1 realtimeBaseCycles:1239417811603646 realtimeBaseRef:1584587626020444987 realtimeFrequency:2299774555} D0319 03:13:47.020171 25681 parameters.go:238] Clock(Monotonic): error: 156 ns, adjusted frequency from 2299773583 Hz to 2299774675 Hz D0319 03:13:47.020390 25681 parameters.go:238] Clock(Realtime): error: -129 ns, adjusted frequency from 2299774555 Hz to 2299774135 Hz D0319 03:13:47.020504 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239420110706964 monotonicBaseRef:58000286859 monotonicFrequency:2299774675 realtimeReady:1 realtimeBaseCycles:1239420111240751 realtimeBaseRef:1584587627020385220 realtimeFrequency:2299774135} D0319 03:13:48.020158 25681 parameters.go:238] Clock(Monotonic): error: -196 ns, adjusted frequency from 2299774675 Hz to 2299773982 Hz D0319 03:13:48.020381 25681 parameters.go:238] Clock(Realtime): error: 171 ns, adjusted frequency from 2299774135 Hz to 2299774827 Hz D0319 03:13:48.020503 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239422410441708 monotonicBaseRef:59000269495 monotonicFrequency:2299773982 realtimeReady:1 realtimeBaseCycles:1239422410991722 realtimeBaseRef:1584587628020375147 realtimeFrequency:2299774827} D0319 03:13:49.020072 25681 parameters.go:238] Clock(Monotonic): error: 183 ns, adjusted frequency from 2299773982 Hz to 2299774844 Hz D0319 03:13:49.020338 25681 parameters.go:238] Clock(Realtime): error: 125 ns, adjusted frequency from 2299774827 Hz to 2299774620 Hz D0319 03:13:49.020507 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239424710025534 monotonicBaseRef:60000186810 monotonicFrequency:2299774844 realtimeReady:1 realtimeBaseCycles:1239424710665423 realtimeBaseRef:1584587629020331174 realtimeFrequency:2299774620} D0319 03:13:50.020161 25681 parameters.go:238] Clock(Monotonic): error: 45 ns, adjusted frequency from 2299774844 Hz to 2299774541 Hz D0319 03:13:50.020407 25681 parameters.go:238] Clock(Realtime): error: -181 ns, adjusted frequency from 2299774620 Hz to 2299774094 Hz D0319 03:13:50.020564 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239427010002028 monotonicBaseRef:61000274492 monotonicFrequency:2299774541 realtimeReady:1 realtimeBaseCycles:1239427010596335 realtimeBaseRef:1584587630020399133 realtimeFrequency:2299774094} D0319 03:13:51.020121 25681 parameters.go:238] Clock(Monotonic): error: -47 ns, adjusted frequency from 2299774541 Hz to 2299774336 Hz D0319 03:13:51.020314 25681 parameters.go:238] Clock(Realtime): error: -118 ns, adjusted frequency from 2299774094 Hz to 2299774180 Hz D0319 03:13:51.020452 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239429309689649 monotonicBaseRef:62000236696 monotonicFrequency:2299774336 realtimeReady:1 realtimeBaseCycles:1239429310163290 realtimeBaseRef:1584587631020309063 realtimeFrequency:2299774180} D0319 03:13:52.020144 25681 parameters.go:238] Clock(Monotonic): error: 333 ns, adjusted frequency from 2299774336 Hz to 2299775224 Hz D0319 03:13:52.020400 25681 parameters.go:238] Clock(Realtime): error: 237 ns, adjusted frequency from 2299774180 Hz to 2299774961 Hz D0319 03:13:52.020557 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239431609521630 monotonicBaseRef:63000261761 monotonicFrequency:2299775224 realtimeReady:1 realtimeBaseCycles:1239431610130679 realtimeBaseRef:1584587632020393075 realtimeFrequency:2299774961} D0319 03:13:53.020185 25681 parameters.go:238] Clock(Monotonic): error: -411 ns, adjusted frequency from 2299775224 Hz to 2299773540 Hz D0319 03:13:53.020500 25681 parameters.go:238] Clock(Realtime): error: -344 ns, adjusted frequency from 2299774961 Hz to 2299773642 Hz D0319 03:13:53.020718 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239433909382273 monotonicBaseRef:64000298903 monotonicFrequency:2299773540 realtimeReady:1 realtimeBaseCycles:1239433910128271 realtimeBaseRef:1584587633020489880 realtimeFrequency:2299773642} D0319 03:13:53.748601 25681 urpc.go:577] urpc: unmarshal success. D0319 03:13:53.748836 25681 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0319 03:13:53.750509 25681 urpc.go:534] urpc: successfully marshalled 37 bytes. D0319 03:13:54.021125 25681 parameters.go:238] Clock(Monotonic): error: 250 ns, adjusted frequency from 2299773540 Hz to 2299775036 Hz D0319 03:13:54.021356 25681 parameters.go:238] Clock(Realtime): error: 193 ns, adjusted frequency from 2299773642 Hz to 2299774851 Hz D0319 03:13:54.021467 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239436209040830 monotonicBaseRef:65000248905 monotonicFrequency:2299775036 realtimeReady:1 realtimeBaseCycles:1239436211880359 realtimeBaseRef:1584587634021350158 realtimeFrequency:2299774851} D0319 03:13:55.020653 25681 parameters.go:238] Clock(Monotonic): error: 192 ns, adjusted frequency from 2299775036 Hz to 2299774828 Hz D0319 03:13:55.020873 25681 parameters.go:238] Clock(Realtime): error: 123 ns, adjusted frequency from 2299774851 Hz to 2299774714 Hz D0319 03:13:55.021054 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239438509992166 monotonicBaseRef:66000760389 monotonicFrequency:2299774828 realtimeReady:1 realtimeBaseCycles:1239438510535828 realtimeBaseRef:1584587635020863422 realtimeFrequency:2299774714} D0319 03:13:56.020807 25681 parameters.go:238] Clock(Monotonic): error: 100 ns, adjusted frequency from 2299774828 Hz to 2299774736 Hz D0319 03:13:56.021014 25681 parameters.go:238] Clock(Realtime): error: -20 ns, adjusted frequency from 2299774714 Hz to 2299774395 Hz D0319 03:13:56.021160 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239440810144053 monotonicBaseRef:67000924343 monotonicFrequency:2299774736 realtimeReady:1 realtimeBaseCycles:1239440810645063 realtimeBaseRef:1584587636021008880 realtimeFrequency:2299774395} D0319 03:13:57.020138 25681 parameters.go:238] Clock(Monotonic): error: -305 ns, adjusted frequency from 2299774736 Hz to 2299773653 Hz D0319 03:13:57.020413 25681 parameters.go:238] Clock(Realtime): error: -211 ns, adjusted frequency from 2299774395 Hz to 2299773935 Hz D0319 03:13:57.020600 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239443108379249 monotonicBaseRef:68000254912 monotonicFrequency:2299773653 realtimeReady:1 realtimeBaseCycles:1239443109035768 realtimeBaseRef:1584587637020407216 realtimeFrequency:2299773935} D0319 03:13:58.020168 25681 parameters.go:238] Clock(Monotonic): error: -162 ns, adjusted frequency from 2299773653 Hz to 2299773950 Hz D0319 03:13:58.020445 25681 parameters.go:238] Clock(Realtime): error: 61 ns, adjusted frequency from 2299773935 Hz to 2299774525 Hz D0319 03:13:58.020613 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239445408221917 monotonicBaseRef:69000284921 monotonicFrequency:2299773950 realtimeReady:1 realtimeBaseCycles:1239445408879731 realtimeBaseRef:1584587638020437665 realtimeFrequency:2299774525} D0319 03:13:59.020101 25681 parameters.go:238] Clock(Monotonic): error: 66 ns, adjusted frequency from 2299773950 Hz to 2299774469 Hz D0319 03:13:59.020276 25681 parameters.go:238] Clock(Realtime): error: 144 ns, adjusted frequency from 2299774525 Hz to 2299774690 Hz D0319 03:13:59.020424 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239447707824914 monotonicBaseRef:70000210586 monotonicFrequency:2299774469 realtimeReady:1 realtimeBaseCycles:1239447708270760 realtimeBaseRef:1584587639020270911 realtimeFrequency:2299774690} D0319 03:14:00.020020 25681 parameters.go:238] Clock(Monotonic): error: -38 ns, adjusted frequency from 2299774469 Hz to 2299774330 Hz D0319 03:14:00.020267 25681 parameters.go:238] Clock(Realtime): error: 13 ns, adjusted frequency from 2299774690 Hz to 2299774399 Hz D0319 03:14:00.020422 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239450007392519 monotonicBaseRef:71000120636 monotonicFrequency:2299774330 realtimeReady:1 realtimeBaseCycles:1239450008019677 realtimeBaseRef:1584587640020259704 realtimeFrequency:2299774399} D0319 03:14:01.020035 25681 parameters.go:238] Clock(Monotonic): error: 240 ns, adjusted frequency from 2299774330 Hz to 2299774958 Hz D0319 03:14:01.020300 25681 parameters.go:238] Clock(Realtime): error: 256 ns, adjusted frequency from 2299774399 Hz to 2299775007 Hz D0319 03:14:01.020420 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239452307223095 monotonicBaseRef:72000145093 monotonicFrequency:2299774958 realtimeReady:1 realtimeBaseCycles:1239452307871960 realtimeBaseRef:1584587641020293569 realtimeFrequency:2299775007} D0319 03:14:02.020128 25681 parameters.go:238] Clock(Monotonic): error: 112 ns, adjusted frequency from 2299774958 Hz to 2299774633 Hz D0319 03:14:02.020365 25681 parameters.go:238] Clock(Realtime): error: -388 ns, adjusted frequency from 2299775007 Hz to 2299773515 Hz D0319 03:14:02.020501 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239454607228122 monotonicBaseRef:73000245132 monotonicFrequency:2299774633 realtimeReady:1 realtimeBaseCycles:1239454607796357 realtimeBaseRef:1584587642020358527 realtimeFrequency:2299773515} D0319 03:14:03.020821 25681 parameters.go:238] Clock(Monotonic): error: -387 ns, adjusted frequency from 2299774633 Hz to 2299773593 Hz D0319 03:14:03.021081 25681 parameters.go:238] Clock(Realtime): error: 276 ns, adjusted frequency from 2299773515 Hz to 2299775075 Hz D0319 03:14:03.021222 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239456908594911 monotonicBaseRef:74000937441 monotonicFrequency:2299773593 realtimeReady:1 realtimeBaseCycles:1239456909216530 realtimeBaseRef:1584587643021074535 realtimeFrequency:2299775075} D0319 03:14:04.020050 25681 parameters.go:238] Clock(Monotonic): error: 222 ns, adjusted frequency from 2299773593 Hz to 2299774885 Hz D0319 03:14:04.020227 25681 parameters.go:238] Clock(Realtime): error: -257 ns, adjusted frequency from 2299775075 Hz to 2299773837 Hz D0319 03:14:04.020413 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239459206601749 monotonicBaseRef:75000169211 monotonicFrequency:2299774885 realtimeReady:1 realtimeBaseCycles:1239459207030965 realtimeBaseRef:1584587644020221999 realtimeFrequency:2299773837} D0319 03:14:05.020676 25681 parameters.go:238] Clock(Monotonic): error: 4 ns, adjusted frequency from 2299774885 Hz to 2299774375 Hz D0319 03:14:05.020884 25681 parameters.go:238] Clock(Realtime): error: -21 ns, adjusted frequency from 2299773837 Hz to 2299774296 Hz D0319 03:14:05.020982 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239461507804830 monotonicBaseRef:76000790226 monotonicFrequency:2299774375 realtimeReady:1 realtimeBaseCycles:1239461508313425 realtimeBaseRef:1584587645020877986 realtimeFrequency:2299774296} D0319 03:14:06.020168 25681 parameters.go:238] Clock(Monotonic): error: -48 ns, adjusted frequency from 2299774375 Hz to 2299774289 Hz D0319 03:14:06.020378 25681 parameters.go:238] Clock(Realtime): error: 195 ns, adjusted frequency from 2299774296 Hz to 2299774905 Hz D0319 03:14:06.020569 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239463806420398 monotonicBaseRef:77000286347 monotonicFrequency:2299774289 realtimeReady:1 realtimeBaseCycles:1239463806925394 realtimeBaseRef:1584587646020372576 realtimeFrequency:2299774905} D0319 03:14:07.020130 25681 parameters.go:238] Clock(Monotonic): error: 134 ns, adjusted frequency from 2299774289 Hz to 2299774749 Hz D0319 03:14:07.020347 25681 parameters.go:238] Clock(Realtime): error: -85 ns, adjusted frequency from 2299774905 Hz to 2299774263 Hz D0319 03:14:07.020512 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239466106083899 monotonicBaseRef:78000238173 monotonicFrequency:2299774749 realtimeReady:1 realtimeBaseCycles:1239466106626428 realtimeBaseRef:1584587647020340455 realtimeFrequency:2299774263} D0319 03:14:08.020078 25681 parameters.go:238] Clock(Monotonic): error: 138 ns, adjusted frequency from 2299774749 Hz to 2299774772 Hz D0319 03:14:08.020300 25681 parameters.go:238] Clock(Realtime): error: -23 ns, adjusted frequency from 2299774263 Hz to 2299774391 Hz D0319 03:14:08.020422 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239468405729465 monotonicBaseRef:79000182000 monotonicFrequency:2299774772 realtimeReady:1 realtimeBaseCycles:1239468406292530 realtimeBaseRef:1584587648020293423 realtimeFrequency:2299774391} D0319 03:14:09.021543 25681 parameters.go:238] Clock(Monotonic): error: -255 ns, adjusted frequency from 2299774772 Hz to 2299773703 Hz D0319 03:14:09.021771 25681 parameters.go:238] Clock(Realtime): error: -89 ns, adjusted frequency from 2299774391 Hz to 2299774228 Hz D0319 03:14:09.021922 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239470708905447 monotonicBaseRef:80001660931 monotonicFrequency:2299773703 realtimeReady:1 realtimeBaseCycles:1239470709443870 realtimeBaseRef:1584587649021761805 realtimeFrequency:2299774228} D0319 03:14:10.020643 25681 parameters.go:238] Clock(Monotonic): error: 128 ns, adjusted frequency from 2299773703 Hz to 2299774726 Hz D0319 03:14:10.020951 25681 parameters.go:238] Clock(Realtime): error: -45 ns, adjusted frequency from 2299774228 Hz to 2299774353 Hz D0319 03:14:10.021194 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239473006606875 monotonicBaseRef:81000759853 monotonicFrequency:2299774726 realtimeReady:1 realtimeBaseCycles:1239473007331065 realtimeBaseRef:1584587650020941275 realtimeFrequency:2299774353} D0319 03:14:11.021254 25681 parameters.go:238] Clock(Monotonic): error: 121 ns, adjusted frequency from 2299774726 Hz to 2299774689 Hz D0319 03:14:11.021492 25681 parameters.go:238] Clock(Realtime): error: 672 ns, adjusted frequency from 2299774353 Hz to 2299775988 Hz D0319 03:14:11.021688 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239475307788524 monotonicBaseRef:82001371618 monotonicFrequency:2299774689 realtimeReady:1 realtimeBaseCycles:1239475308356948 realtimeBaseRef:1584587651021485471 realtimeFrequency:2299775988} D0319 03:14:12.020143 25681 parameters.go:238] Clock(Monotonic): error: -369 ns, adjusted frequency from 2299774689 Hz to 2299773490 Hz D0319 03:14:12.020314 25681 parameters.go:238] Clock(Realtime): error: -675 ns, adjusted frequency from 2299775988 Hz to 2299772838 Hz D0319 03:14:12.020427 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239477605010857 monotonicBaseRef:83000261789 monotonicFrequency:2299773490 realtimeReady:1 realtimeBaseCycles:1239477605426697 realtimeBaseRef:1584587652020308730 realtimeFrequency:2299772838} D0319 03:14:13.020069 25681 parameters.go:238] Clock(Monotonic): error: 244 ns, adjusted frequency from 2299773490 Hz to 2299775003 Hz D0319 03:14:13.020282 25681 parameters.go:238] Clock(Realtime): error: 62 ns, adjusted frequency from 2299772838 Hz to 2299774560 Hz D0319 03:14:13.020395 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239479904612510 monotonicBaseRef:84000187069 monotonicFrequency:2299775003 realtimeReady:1 realtimeBaseCycles:1239479905126043 realtimeBaseRef:1584587653020276773 realtimeFrequency:2299774560} D0319 03:14:14.020165 25681 parameters.go:238] Clock(Monotonic): error: 29 ns, adjusted frequency from 2299775003 Hz to 2299774493 Hz D0319 03:14:14.020343 25681 parameters.go:238] Clock(Realtime): error: -61 ns, adjusted frequency from 2299774560 Hz to 2299774330 Hz D0319 03:14:14.020441 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239482204611333 monotonicBaseRef:85000284391 monotonicFrequency:2299774493 realtimeReady:1 realtimeBaseCycles:1239482205041154 realtimeBaseRef:1584587654020337888 realtimeFrequency:2299774330} D0319 03:14:15.020149 25681 parameters.go:238] Clock(Monotonic): error: -97 ns, adjusted frequency from 2299774493 Hz to 2299774157 Hz D0319 03:14:15.020390 25681 parameters.go:238] Clock(Realtime): error: 129 ns, adjusted frequency from 2299774330 Hz to 2299774693 Hz D0319 03:14:15.020526 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239484504292331 monotonicBaseRef:86000243737 monotonicFrequency:2299774157 realtimeReady:1 realtimeBaseCycles:1239484504910474 realtimeBaseRef:1584587655020379192 realtimeFrequency:2299774693} D0319 03:14:16.020377 25681 parameters.go:238] Clock(Monotonic): error: 153 ns, adjusted frequency from 2299774157 Hz to 2299774771 Hz D0319 03:14:16.020614 25681 parameters.go:238] Clock(Realtime): error: -104 ns, adjusted frequency from 2299774693 Hz to 2299774211 Hz D0319 03:14:16.020729 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239486804644206 monotonicBaseRef:87000494943 monotonicFrequency:2299774771 realtimeReady:1 realtimeBaseCycles:1239486805212092 realtimeBaseRef:1584587656020608312 realtimeFrequency:2299774211} D0319 03:14:17.021367 25681 parameters.go:238] Clock(Monotonic): error: -170 ns, adjusted frequency from 2299774771 Hz to 2299774096 Hz D0319 03:14:17.021637 25681 parameters.go:238] Clock(Realtime): error: 88 ns, adjusted frequency from 2299774211 Hz to 2299774580 Hz D0319 03:14:17.021750 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239489106689423 monotonicBaseRef:88001482190 monotonicFrequency:2299774096 realtimeReady:1 realtimeBaseCycles:1239489107333790 realtimeBaseRef:1584587657021629058 realtimeFrequency:2299774580} D0319 03:14:18.020151 25681 parameters.go:238] Clock(Monotonic): error: 57 ns, adjusted frequency from 2299774096 Hz to 2299774620 Hz D0319 03:14:18.020379 25681 parameters.go:238] Clock(Realtime): error: -103 ns, adjusted frequency from 2299774580 Hz to 2299774222 Hz D0319 03:14:18.020562 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239491403665072 monotonicBaseRef:89000265354 monotonicFrequency:2299774620 realtimeReady:1 realtimeBaseCycles:1239491404220744 realtimeBaseRef:1584587658020373445 realtimeFrequency:2299774222} D0319 03:14:19.021963 25681 parameters.go:238] Clock(Monotonic): error: -131 ns, adjusted frequency from 2299774620 Hz to 2299774072 Hz D0319 03:14:19.022255 25681 parameters.go:238] Clock(Realtime): error: 37 ns, adjusted frequency from 2299774222 Hz to 2299774527 Hz D0319 03:14:19.022400 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239493707602073 monotonicBaseRef:90002075262 monotonicFrequency:2299774072 realtimeReady:1 realtimeBaseCycles:1239493708305521 realtimeBaseRef:1584587659022247783 realtimeFrequency:2299774527} I0319 03:14:19.199023 25681 watchdog.go:277] Watchdog starting loop, tasks: 14, discount: 0s D0319 03:14:20.020169 25681 parameters.go:238] Clock(Monotonic): error: -85 ns, adjusted frequency from 2299774072 Hz to 2299774176 Hz D0319 03:14:20.020405 25681 parameters.go:238] Clock(Realtime): error: 54 ns, adjusted frequency from 2299774527 Hz to 2299774548 Hz D0319 03:14:20.020506 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239496003229801 monotonicBaseRef:91000272326 monotonicFrequency:2299774176 realtimeReady:1 realtimeBaseCycles:1239496003829909 realtimeBaseRef:1584587660020399715 realtimeFrequency:2299774548} D0319 03:14:21.020022 25681 parameters.go:238] Clock(Monotonic): error: 102 ns, adjusted frequency from 2299774176 Hz to 2299774583 Hz D0319 03:14:21.020273 25681 parameters.go:238] Clock(Realtime): error: -3 ns, adjusted frequency from 2299774548 Hz to 2299774415 Hz D0319 03:14:21.020396 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239498302695740 monotonicBaseRef:92000138296 monotonicFrequency:2299774583 realtimeReady:1 realtimeBaseCycles:1239498303300008 realtimeBaseRef:1584587661020267332 realtimeFrequency:2299774415} D0319 03:14:22.020181 25681 parameters.go:238] Clock(Monotonic): error: -77 ns, adjusted frequency from 2299774583 Hz to 2299774332 Hz D0319 03:14:22.020490 25681 parameters.go:238] Clock(Realtime): error: 211 ns, adjusted frequency from 2299774415 Hz to 2299774884 Hz D0319 03:14:22.020649 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239500602830178 monotonicBaseRef:93000294770 monotonicFrequency:2299774332 realtimeReady:1 realtimeBaseCycles:1239500603571407 realtimeBaseRef:1584587662020483433 realtimeFrequency:2299774884} D0319 03:14:23.020347 25681 parameters.go:238] Clock(Monotonic): error: -223 ns, adjusted frequency from 2299774332 Hz to 2299773958 Hz D0319 03:14:23.020626 25681 parameters.go:238] Clock(Realtime): error: -197 ns, adjusted frequency from 2299774884 Hz to 2299773971 Hz D0319 03:14:23.020766 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239502902979850 monotonicBaseRef:94000457977 monotonicFrequency:2299773958 realtimeReady:1 realtimeBaseCycles:1239502903661510 realtimeBaseRef:1584587663020620498 realtimeFrequency:2299773971} D0319 03:14:24.020146 25681 parameters.go:238] Clock(Monotonic): error: 486 ns, adjusted frequency from 2299773958 Hz to 2299775572 Hz D0319 03:14:24.020396 25681 parameters.go:238] Clock(Realtime): error: -29 ns, adjusted frequency from 2299773971 Hz to 2299774323 Hz D0319 03:14:24.020582 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239505202295637 monotonicBaseRef:95000258752 monotonicFrequency:2299775572 realtimeReady:1 realtimeBaseCycles:1239505202902982 realtimeBaseRef:1584587664020388953 realtimeFrequency:2299774323} I0319 03:14:24.442721 31196 main.go:305] *************************** I0319 03:14:24.442979 31196 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=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller354288183] I0319 03:14:24.443438 31196 main.go:307] Version release-20200219.0-192-gfc16e64396cf I0319 03:14:24.443521 31196 main.go:308] PID: 31196 I0319 03:14:24.443599 31196 main.go:309] UID: 0, GID: 0 I0319 03:14:24.443702 31196 main.go:310] Configuration: I0319 03:14:24.443782 31196 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0319 03:14:24.443850 31196 main.go:312] Platform: ptrace I0319 03:14:24.443915 31196 main.go:313] FileAccess: shared, overlay: false I0319 03:14:24.444019 31196 main.go:314] Network: sandbox, logging: false I0319 03:14:24.444104 31196 main.go:315] Strace: false, max size: 1024, syscalls: [] I0319 03:14:24.444188 31196 main.go:316] *************************** W0319 03:14:24.444265 31196 main.go:321] Block the TERM signal. This is only safe in tests! D0319 03:14:24.444687 31196 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.451833 31196 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0319 03:14:24.452025 31196 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.452128 31196 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.452926 25681 urpc.go:577] urpc: unmarshal success. D0319 03:14:24.453161 25681 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0319 03:14:24.453420 25681 urpc.go:534] urpc: successfully marshalled 37 bytes. D0319 03:14:24.452680 31196 urpc.go:534] urpc: successfully marshalled 117 bytes. D0319 03:14:24.458616 31196 urpc.go:577] urpc: unmarshal success. D0319 03:14:24.458873 31196 exec.go:120] Exec arguments: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller354288183 D0319 03:14:24.459139 31196 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0319 03:14:24.459349 31196 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=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller354288183 D0319 03:14:24.459566 31196 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-2" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.459800 31196 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.460868 31196 urpc.go:534] urpc: successfully marshalled 634 bytes. D0319 03:14:24.461894 25681 urpc.go:577] urpc: unmarshal success. D0319 03:14:24.463285 25681 controller.go:270] containerManager.ExecuteAsync: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller354288183 D0319 03:14:24.464984 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0319 03:14:24.466201 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:24.467457 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0319 03:14:24.469050 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} I0319 03:14:24.469912 25681 kernel.go:807] EXEC: [/syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller354288183] D0319 03:14:24.471652 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0319 03:14:24.476511 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] 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: 1584563391, NanoSec: 160457642}, MTime: {Sec: 1584563391, NanoSec: 160457642}, CTime: {Sec: 1584587570, NanoSec: 805799294}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 6428068}]} D0319 03:14:24.477576 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0319 03:14:24.478753 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:24.479250 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0319 03:14:24.480304 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 6428068}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 24180480, BlockSize: 4096, Blocks: 47232, ATime: {Sec: 1584563391, NanoSec: 160457642}, MTime: {Sec: 1584563391, NanoSec: 160457642}, CTime: {Sec: 1584587570, NanoSec: 805799294}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0319 03:14:24.480445 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalk{FID: 5, NewFID: 6, Names: []} D0319 03:14:24.481893 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rwalk{QIDs: []} D0319 03:14:24.482060 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tlopen{FID: 6, Flags: ReadOnly} D0319 03:14:24.482975 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 6428068}, IoUnit: 0, File: &{{37}}} D0319 03:14:24.493562 25681 syscalls.go:266] Allocating stack with size of 8388608 bytes D0319 03:14:24.495323 25681 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-2 0}:0xc000386b00 {ci-gvisor-ptrace-proxy-sandbox-race-2 20}:0xc00062e7e0] D0319 03:14:24.495824 25681 urpc.go:534] urpc: successfully marshalled 37 bytes. D0319 03:14:24.498743 31196 urpc.go:577] urpc: unmarshal success. D0319 03:14:24.498931 31196 container.go:580] Wait on PID 20 in container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.499086 31196 sandbox.go:769] Waiting for PID 20 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.499224 31196 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:24.499566 31196 urpc.go:534] urpc: successfully marshalled 100 bytes. D0319 03:14:24.500595 25681 urpc.go:577] urpc: unmarshal success. D0319 03:14:24.500907 25681 controller.go:446] containerManager.Wait D0319 03:14:24.540080 25681 task_block.go:223] [ 20] Interrupt queued D0319 03:14:24.896619 25681 task_block.go:223] [ 21] Interrupt queued D0319 03:14:24.916115 25681 task_block.go:223] [ 22] Interrupt queued D0319 03:14:24.932327 25681 task_block.go:223] [ 23] Interrupt queued D0319 03:14:25.020113 25681 parameters.go:238] Clock(Monotonic): error: -66 ns, adjusted frequency from 2299775572 Hz to 2299774282 Hz D0319 03:14:25.020341 25681 parameters.go:238] Clock(Realtime): error: -48 ns, adjusted frequency from 2299774323 Hz to 2299774320 Hz D0319 03:14:25.020477 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239507501972089 monotonicBaseRef:96000215652 monotonicFrequency:2299774282 realtimeReady:1 realtimeBaseCycles:1239507502551917 realtimeBaseRef:1584587665020334431 realtimeFrequency:2299774320} D0319 03:14:25.039330 25681 task_block.go:223] [ 25] Interrupt queued D0319 03:14:25.045855 25681 task_block.go:223] [ 26] Interrupt queued D0319 03:14:25.046232 25681 task_block.go:223] [ 24] Interrupt queued D0319 03:14:25.070237 25681 task_block.go:223] [ 27] Interrupt queued D0319 03:14:25.090098 25681 urpc.go:577] urpc: unmarshal success. D0319 03:14:25.090355 25681 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0319 03:14:25.090602 25681 urpc.go:534] urpc: successfully marshalled 37 bytes. D0319 03:14:25.142325 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0319 03:14:25.143576 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.143799 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0319 03:14:25.144434 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.238729 25681 task_block.go:223] [ 28] Interrupt queued D0319 03:14:25.267099 25681 task_block.go:223] [ 29] Interrupt queued D0319 03:14:25.273215 25681 task_block.go:223] [ 30] Interrupt queued D0319 03:14:25.276605 25681 task_block.go:223] [ 31] Interrupt queued D0319 03:14:25.284104 25681 task_block.go:223] [ 32] Interrupt queued D0319 03:14:25.315858 25681 task_block.go:223] [ 33] Interrupt queued D0319 03:14:25.369603 25681 task_block.go:223] [ 34] Interrupt queued D0319 03:14:25.437974 25681 task_block.go:223] [ 35] Interrupt queued D0319 03:14:25.468127 25681 task_block.go:223] [ 36] Interrupt queued D0319 03:14:25.473829 25681 task_block.go:223] [ 37] Interrupt queued D0319 03:14:25.476438 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller354288183]} D0319 03:14:25.477845 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] 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: 464, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1584587664, NanoSec: 366975658}, MTime: {Sec: 1584587664, NanoSec: 366975658}, CTime: {Sec: 1584587664, NanoSec: 366975658}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 6428070}]} D0319 03:14:25.478136 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller354288183, Size: 1} D0319 03:14:25.478614 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.479819 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0319 03:14:25.480731 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 6428070}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 464, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1584587664, NanoSec: 366975658}, MTime: {Sec: 1584587664, NanoSec: 366975658}, CTime: {Sec: 1584587664, NanoSec: 366975658}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0319 03:14:25.481059 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalk{FID: 7, NewFID: 8, Names: []} D0319 03:14:25.481838 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rwalk{QIDs: []} D0319 03:14:25.482115 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tlopen{FID: 8, Flags: ReadOnly} D0319 03:14:25.485138 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 6428070}, IoUnit: 0, File: &{{29}}} D0319 03:14:25.489902 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0319 03:14:25.492352 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 6428070}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 464, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1584587664, NanoSec: 366975658}, MTime: {Sec: 1584587664, NanoSec: 366975658}, CTime: {Sec: 1584587664, NanoSec: 366975658}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/19 03:14:25 parsed 1 programs D0319 03:14:25.513016 25681 task_stop.go:118] [ 31] Entering internal stop (*kernel.vforkStop)(nil) D0319 03:14:25.513828 25681 task_block.go:223] [ 38] Interrupt queued D0319 03:14:25.545621 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0319 03:14:25.547739 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] 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: 1584563392, NanoSec: 472586272}, MTime: {Sec: 1584563392, NanoSec: 472586272}, CTime: {Sec: 1584587570, NanoSec: 813800079}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 6428069}]} D0319 03:14:25.548025 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0319 03:14:25.548701 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.549100 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0319 03:14:25.550193 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 6428069}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1584563392, NanoSec: 472586272}, MTime: {Sec: 1584563392, NanoSec: 472586272}, CTime: {Sec: 1584587570, NanoSec: 813800079}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0319 03:14:25.550544 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalk{FID: 9, NewFID: 10, Names: []} D0319 03:14:25.551518 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rwalk{QIDs: []} D0319 03:14:25.551764 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tlopen{FID: 10, Flags: ReadOnly} D0319 03:14:25.552689 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 6428069}, IoUnit: 0, File: &{{30}}} D0319 03:14:25.553691 25681 syscalls.go:266] [ 38] Allocating stack with size of 8388608 bytes D0319 03:14:25.554859 25681 task_stop.go:137] [ 31] Leaving internal stop (*kernel.vforkStop)(nil) D0319 03:14:25.607644 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0319 03:14:25.608262 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.608412 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0319 03:14:25.610512 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.618245 25681 task_exit.go:221] [ 38] Transitioning from exit state TaskExitNone to TaskExitInitiated D0319 03:14:25.619690 25681 task_exit.go:221] [ 38] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0319 03:14:25.619889 25681 task_signals.go:446] [ 20] Notified of signal 17 D0319 03:14:25.620068 25681 task_block.go:223] [ 20] Interrupt queued D0319 03:14:25.620232 25681 task_block.go:223] [ 20] Interrupt queued D0319 03:14:25.620379 25681 task_signals.go:179] [ 20] Restarting syscall 202 after errno 512: interrupted by signal 17 D0319 03:14:25.620615 25681 task_signals.go:220] [ 20] Signal 17: delivering to handler D0319 03:14:25.621499 25681 task_exit.go:221] [ 38] Transitioning from exit state TaskExitZombie to TaskExitDead D0319 03:14:25.625862 25681 task_block.go:223] [ 39] Interrupt queued D0319 03:14:25.629935 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0319 03:14:25.632747 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] 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: 1584563392, NanoSec: 472586272}, MTime: {Sec: 1584563392, NanoSec: 472586272}, CTime: {Sec: 1584587570, NanoSec: 813800079}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 6428069}]} D0319 03:14:25.633009 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tclunk{FID: 11} D0319 03:14:25.633494 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rclunk{} D0319 03:14:25.633729 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0319 03:14:25.634593 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 6428069}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1584563392, NanoSec: 472586272}, MTime: {Sec: 1584563392, NanoSec: 472586272}, CTime: {Sec: 1584587570, NanoSec: 813800079}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/19 03:14:25 executed programs: 0 D0319 03:14:25.647198 25681 task_stop.go:118] [ 30] Entering internal stop (*kernel.vforkStop)(nil) D0319 03:14:25.648001 25681 task_block.go:223] [ 40] Interrupt queued D0319 03:14:25.654575 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0319 03:14:25.655988 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] 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: 1584563392, NanoSec: 472586272}, MTime: {Sec: 1584563392, NanoSec: 472586272}, CTime: {Sec: 1584587570, NanoSec: 813800079}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 6428069}]} D0319 03:14:25.656151 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tclunk{FID: 11} D0319 03:14:25.656638 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rclunk{} D0319 03:14:25.657019 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0319 03:14:25.663582 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 6428069}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1584563392, NanoSec: 472586272}, MTime: {Sec: 1584563392, NanoSec: 472586272}, CTime: {Sec: 1584587570, NanoSec: 813800079}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0319 03:14:25.668168 25681 syscalls.go:266] [ 40] Allocating stack with size of 8388608 bytes D0319 03:14:25.669222 25681 task_stop.go:137] [ 30] Leaving internal stop (*kernel.vforkStop)(nil) D0319 03:14:25.682040 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0319 03:14:25.682718 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.682970 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0319 03:14:25.683728 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.716261 25681 task_block.go:223] [ 41] Interrupt queued D0319 03:14:25.724771 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.725592 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.725777 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.726304 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.726689 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.727370 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.727559 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.728054 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.728751 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.729768 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.729942 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.730568 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.731004 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.731621 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.731839 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.732285 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.732687 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.733268 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.733452 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.734164 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.735722 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.736277 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.736427 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.737727 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.738032 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.738522 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.738656 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.739011 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.739235 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.740067 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.740198 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.740776 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.741708 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:25.742353 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:25.742587 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:25.743303 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:25.783210 25681 netfilter.go:60] netfilter: convert to binary: current offset: 0 D0319 03:14:25.783388 25681 netfilter.go:60] netfilter: convert to binary: found hook 0 at offset 0 D0319 03:14:25.783507 25681 netfilter.go:60] netfilter: convert to binary: found underflow 0 at offset 0 D0319 03:14:25.783582 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.783667 25681 netfilter.go:60] 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]} D0319 03:14:25.784295 25681 netfilter.go:60] netfilter: convert to binary: current offset: 152 D0319 03:14:25.784411 25681 netfilter.go:60] netfilter: convert to binary: found hook 1 at offset 152 D0319 03:14:25.784510 25681 netfilter.go:60] netfilter: convert to binary: found underflow 1 at offset 152 D0319 03:14:25.784622 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.784799 25681 netfilter.go:60] 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]} D0319 03:14:25.785567 25681 netfilter.go:60] netfilter: convert to binary: current offset: 304 D0319 03:14:25.785661 25681 netfilter.go:60] netfilter: convert to binary: found hook 3 at offset 304 D0319 03:14:25.785788 25681 netfilter.go:60] netfilter: convert to binary: found underflow 3 at offset 304 D0319 03:14:25.785932 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.786063 25681 netfilter.go:60] 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]} D0319 03:14:25.786680 25681 netfilter.go:60] netfilter: convert to binary: current offset: 456 D0319 03:14:25.786829 25681 netfilter.go:60] netfilter: convert to binary: found hook 4 at offset 456 D0319 03:14:25.786949 25681 netfilter.go:60] netfilter: convert to binary: found underflow 4 at offset 456 D0319 03:14:25.787058 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.787177 25681 netfilter.go:60] 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]} D0319 03:14:25.787819 25681 netfilter.go:60] netfilter: convert to binary: current offset: 608 D0319 03:14:25.787925 25681 netfilter.go:60] 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]} D0319 03:14:25.788720 25681 netfilter.go:60] netfilter: convert to binary: finished with an marshalled size of 0 D0319 03:14:25.788856 25681 netfilter.go:60] netfilter: convert to binary: current offset: 0 D0319 03:14:25.788977 25681 netfilter.go:60] netfilter: convert to binary: found hook 0 at offset 0 D0319 03:14:25.789096 25681 netfilter.go:60] netfilter: convert to binary: found underflow 0 at offset 0 D0319 03:14:25.789175 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.789245 25681 netfilter.go:60] 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]} D0319 03:14:25.789790 25681 netfilter.go:60] netfilter: convert to binary: current offset: 152 D0319 03:14:25.789866 25681 netfilter.go:60] netfilter: convert to binary: found hook 3 at offset 152 D0319 03:14:25.789961 25681 netfilter.go:60] netfilter: convert to binary: found underflow 3 at offset 152 D0319 03:14:25.790025 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.790091 25681 netfilter.go:60] 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]} D0319 03:14:25.790641 25681 netfilter.go:60] netfilter: convert to binary: current offset: 304 D0319 03:14:25.790749 25681 netfilter.go:60] 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]} D0319 03:14:25.792868 25681 netfilter.go:60] netfilter: convert to binary: finished with an marshalled size of 0 D0319 03:14:25.792953 25681 netfilter.go:60] netfilter: convert to binary: current offset: 0 D0319 03:14:25.793035 25681 netfilter.go:60] netfilter: convert to binary: found hook 1 at offset 0 D0319 03:14:25.793127 25681 netfilter.go:60] netfilter: convert to binary: found underflow 1 at offset 0 D0319 03:14:25.793232 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.793298 25681 netfilter.go:60] 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]} D0319 03:14:25.793822 25681 netfilter.go:60] netfilter: convert to binary: current offset: 152 D0319 03:14:25.793879 25681 netfilter.go:60] netfilter: convert to binary: found hook 2 at offset 152 D0319 03:14:25.793960 25681 netfilter.go:60] netfilter: convert to binary: found underflow 2 at offset 152 D0319 03:14:25.794041 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.794109 25681 netfilter.go:60] 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]} D0319 03:14:25.794689 25681 netfilter.go:60] netfilter: convert to binary: current offset: 304 D0319 03:14:25.794766 25681 netfilter.go:60] netfilter: convert to binary: found hook 3 at offset 304 D0319 03:14:25.794845 25681 netfilter.go:60] netfilter: convert to binary: found underflow 3 at offset 304 D0319 03:14:25.794912 25681 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0319 03:14:25.794985 25681 netfilter.go:60] 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]} D0319 03:14:25.795484 25681 netfilter.go:60] netfilter: convert to binary: current offset: 456 D0319 03:14:25.795592 25681 netfilter.go:60] 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]} D0319 03:14:25.796200 25681 netfilter.go:60] netfilter: convert to binary: finished with an marshalled size of 0 D0319 03:14:26.020254 25681 parameters.go:238] Clock(Monotonic): error: -297 ns, adjusted frequency from 2299774282 Hz to 2299773693 Hz D0319 03:14:26.020539 25681 parameters.go:238] Clock(Realtime): error: 36 ns, adjusted frequency from 2299774320 Hz to 2299774571 Hz D0319 03:14:26.020663 25681 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1239509802102286 monotonicBaseRef:97000370412 monotonicFrequency:2299773693 realtimeReady:1 realtimeBaseCycles:1239509802778072 realtimeBaseRef:1584587666020530900 realtimeFrequency:2299774571} D0319 03:14:26.026236 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.027062 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.027281 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.028584 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.029080 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.029761 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.029927 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.030526 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.031074 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.031667 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.031906 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.032466 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.032894 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.033456 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.033586 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.034958 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.035188 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.039932 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.040112 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.040764 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.041011 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.041617 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.041845 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.042469 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.042728 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.043268 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.043457 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.044010 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.044399 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.044984 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.045139 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.045536 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.045779 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.046685 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.046857 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.048087 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.048616 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0319 03:14:26.049286 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 2} D0319 03:14:26.049586 25681 transport_flipcall.go:127] send [channel @0xc00032e3c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0319 03:14:26.050960 25681 transport_flipcall.go:234] recv [channel @0xc00032e3c0] Rlerror{Error: 95} D0319 03:14:26.078763 25681 task_block.go:223] [ 42] Interrupt queued D0319 03:14:26.099060 25681 task_block.go:223] [ 43] Interrupt queued I0319 03:14:26.126461 25681 compat.go:122] Unsupported syscall: setsockopt, regs: amd64: I0319 03:14:26.129700 25681 compat.go:122] Unsupported syscall: perf_event_open, regs: amd64: I0319 03:14:26.132161 25681 compat.go:122] Unsupported syscall: setsockopt, regs: amd64: D0319 03:14:26.903212 25681 task_block.go:223] [ 44] Interrupt queued D0319 03:14:26.908354 25681 task_block.go:223] [ 45] Interrupt queued ================== WARNING: DATA RACE Write at 0x00c00089c2a0 by goroutine 351: gvisor.dev/gvisor/pkg/tcpip/transport/tcp.(*endpoint).SetSockOpt() pkg/tcpip/transport/tcp/endpoint.go:1504 +0x34e gvisor.dev/gvisor/pkg/sentry/socket/netstack.setSockOptTCP() pkg/sentry/socket/netstack/netstack.go:1739 +0x35d DIAGNOSIS: I0319 03:14:26.954019 31335 main.go:305] *************************** I0319 03:14:26.954228 31335 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] I0319 03:14:26.954456 31335 main.go:307] Version release-20200219.0-192-gfc16e64396cf I0319 03:14:26.954577 31335 main.go:308] PID: 31335 I0319 03:14:26.954754 31335 main.go:309] UID: 0, GID: 0 I0319 03:14:26.954880 31335 main.go:310] Configuration: I0319 03:14:26.954993 31335 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0319 03:14:26.955089 31335 main.go:312] Platform: ptrace I0319 03:14:26.955207 31335 main.go:313] FileAccess: shared, overlay: false I0319 03:14:26.955336 31335 main.go:314] Network: sandbox, logging: false I0319 03:14:26.955442 31335 main.go:315] Strace: false, max size: 1024, syscalls: [] I0319 03:14:26.955596 31335 main.go:316] *************************** W0319 03:14:26.955702 31335 main.go:321] Block the TERM signal. This is only safe in tests! D0319 03:14:26.955949 31335 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:26.965959 31335 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0319 03:14:26.966189 31335 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:26.966309 31335 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:26.966849 31335 urpc.go:534] urpc: successfully marshalled 117 bytes. I0319 03:14:27.050534 31335 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 25681 I0319 03:14:27.050712 31335 debug.go:137] Retrieving sandbox stacks D0319 03:14:27.051225 31335 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:27.051378 31335 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0319 03:14:27.051629 31335 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 25681: connection refused retrieving stacks: connecting to control server at PID 25681: connection refused W0319 03:14:27.051962 31335 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 I0319 03:14:26.954019 31335 main.go:305] *************************** I0319 03:14:26.954228 31335 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] I0319 03:14:26.954456 31335 main.go:307] Version release-20200219.0-192-gfc16e64396cf I0319 03:14:26.954577 31335 main.go:308] PID: 31335 I0319 03:14:26.954754 31335 main.go:309] UID: 0, GID: 0 I0319 03:14:26.954880 31335 main.go:310] Configuration: I0319 03:14:26.954993 31335 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0319 03:14:26.955089 31335 main.go:312] Platform: ptrace I0319 03:14:26.955207 31335 main.go:313] FileAccess: shared, overlay: false I0319 03:14:26.955336 31335 main.go:314] Network: sandbox, logging: false I0319 03:14:26.955442 31335 main.go:315] Strace: false, max size: 1024, syscalls: [] I0319 03:14:26.955596 31335 main.go:316] *************************** W0319 03:14:26.955702 31335 main.go:321] Block the TERM signal. This is only safe in tests! D0319 03:14:26.955949 31335 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:26.965959 31335 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0319 03:14:26.966189 31335 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:26.966309 31335 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:26.966849 31335 urpc.go:534] urpc: successfully marshalled 117 bytes. I0319 03:14:27.050534 31335 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 25681 I0319 03:14:27.050712 31335 debug.go:137] Retrieving sandbox stacks D0319 03:14:27.051225 31335 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0319 03:14:27.051378 31335 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0319 03:14:27.051629 31335 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 25681: connection refused retrieving stacks: connecting to control server at PID 25681: connection refused W0319 03:14:27.051962 31335 main.go:338] Failure to execute command, err: 1 [302977.009068] [] ? do_syscall_64+0x8d/0x100 [302977.009070] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009072] Task dump for CPU 17: [302977.009074] exe R running task 0 60696 60665 0x00000988 [302977.009076] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.009078] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.009081] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.009081] Call Trace: [302977.009086] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.009090] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009094] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009098] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009101] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009105] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009109] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009113] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009117] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009121] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.009139] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.009158] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.009159] [] ? recalc_sigpending+0x17/0x50 [302977.009177] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.009179] [] ? signal_setup_done+0x67/0xb0 [302977.009181] [] ? __seccomp_filter+0x74/0x270 [302977.009183] [] ? do_vfs_ioctl+0xa2/0x620 [302977.009185] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.009187] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.009189] [] ? SyS_ioctl+0x74/0x80 [302977.009191] [] ? do_syscall_64+0x8d/0x100 [302977.009193] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009194] Task dump for CPU 20: [302977.009196] exe R running task 0 60724 60665 0x00000988 [302977.009199] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.009201] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.009203] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.009203] Call Trace: [302977.009208] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.009212] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009215] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009219] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009223] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009227] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009231] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009235] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009239] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009243] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.009260] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.009278] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302977.009280] [] ? recalc_sigpending+0x17/0x50 [302977.009297] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.009300] [] ? signal_setup_done+0x67/0xb0 [302977.009302] [] ? __seccomp_filter+0x74/0x270 [302977.009304] [] ? do_vfs_ioctl+0xa2/0x620 [302977.009306] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.009308] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.009310] [] ? SyS_ioctl+0x74/0x80 [302977.009312] [] ? do_syscall_64+0x8d/0x100 [302977.009314] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009316] Task dump for CPU 32: [302977.009318] exe R running task 0 4116 60665 0x00000988 [302977.009320] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302977.009322] ffffba196b057de8 ffff9fbd40012000 0000000000000000 0000000000000000 [302977.009324] 0000000000000000 0000000000000000 ffff9faff3c3d140 0002799b30d258e5 [302977.009324] Call Trace: [302977.009329] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.009347] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.009365] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.009367] [] ? recalc_sigpending+0x17/0x50 [302977.009384] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.009386] [] ? signal_setup_done+0x67/0xb0 [302977.009388] [] ? __seccomp_filter+0x74/0x270 [302977.009390] [] ? do_vfs_ioctl+0xa2/0x620 [302977.009392] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.009394] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.009396] [] ? SyS_ioctl+0x74/0x80 [302977.009397] [] ? do_syscall_64+0x8d/0x100 [302977.009400] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009401] Task dump for CPU 33: [302977.009402] exe R running task 0 4112 60665 0x00000988 [302977.009405] ffffffffa1b19a00 ffffffffa0ea953b 0000000000000021 ffffffffa1b19a00 [302977.009407] ffffffffa0f830ad ffff9fca86e596c0 ffffffffa1a4fd80 0000000000000000 [302977.009409] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002ac83f9 [302977.009409] Call Trace: [302977.009412] [302977.009412] [] ? sched_show_task+0xcb/0x130 [302977.009415] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [302977.009418] [] ? rcu_check_callbacks+0x75a/0x8b0 [302977.009420] [] ? tick_sched_do_timer+0x30/0x30 [302977.009422] [] ? update_process_times+0x28/0x50 [302977.009425] [] ? tick_sched_handle.isra.12+0x20/0x50 [302977.009427] [] ? tick_sched_timer+0x38/0x70 [302977.009429] [] ? __hrtimer_run_queues+0xde/0x250 [302977.009431] [] ? hrtimer_interrupt+0x9c/0x1a0 [302977.009433] [] ? smp_apic_timer_interrupt+0x47/0x60 [302977.009435] [] ? apic_timer_interrupt+0x9e/0xb0 [302977.009438] [302977.009438] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.009440] [] ? _raw_spin_lock+0x1d/0x20 [302977.009459] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.009463] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009482] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.009486] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.009490] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009494] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009498] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009501] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009505] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009509] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009513] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009517] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009522] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.009540] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.009558] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.009560] [] ? recalc_sigpending+0x17/0x50 [302977.009577] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.009579] [] ? signal_setup_done+0x67/0xb0 [302977.009581] [] ? __seccomp_filter+0x74/0x270 [302977.009583] [] ? do_vfs_ioctl+0xa2/0x620 [302977.009585] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.009587] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.009589] [] ? SyS_ioctl+0x74/0x80 [302977.009591] [] ? do_syscall_64+0x8d/0x100 [302977.009593] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009594] Task dump for CPU 42: [302977.009596] exe R running task 0 4000 60665 0x00000988 [302977.009599] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302977.009601] ffffba196a92fde8 ffff9fb24e339e80 0000000000000000 0000000000000000 [302977.009603] 0000000000000000 0000000000000000 ffff9faf3bf48000 0002799b31d950a2 [302977.009603] Call Trace: [302977.009607] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.009626] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.009644] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.009646] [] ? recalc_sigpending+0x17/0x50 [302977.009663] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.009665] [] ? signal_setup_done+0x67/0xb0 [302977.009667] [] ? __seccomp_filter+0x74/0x270 [302977.009669] [] ? do_vfs_ioctl+0xa2/0x620 [302977.009671] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.009673] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.009675] [] ? SyS_ioctl+0x74/0x80 [302977.009677] [] ? do_syscall_64+0x8d/0x100 [302977.009679] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009680] Task dump for CPU 45: [302977.009682] exe R running task 0 9811 60665 0x00000188 [302977.009684] 0000000000785fff 00003ffffffff000 0000000000786000 ffffff8000000000 [302977.009686] 0000008000000000 0000000000785fff ffff9fc0b95f6000 0000000000786000 [302977.009688] 0000000000000287 00000001a0e526f6 ffffba197bd07b40 0000000000000287 [302977.009689] Call Trace: [302977.009707] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.009709] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.009711] [] ? _raw_spin_lock+0x1d/0x20 [302977.009730] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.009734] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009752] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.009757] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.009779] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.009797] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.009799] [] ? recalc_sigpending+0x17/0x50 [302977.009816] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.009818] [] ? signal_setup_done+0x67/0xb0 [302977.009820] [] ? __seccomp_filter+0x74/0x270 [302977.009822] [] ? do_vfs_ioctl+0xa2/0x620 [302977.009824] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.009826] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.009828] [] ? SyS_ioctl+0x74/0x80 [302977.009830] [] ? do_syscall_64+0x8d/0x100 [302977.009832] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009833] Task dump for CPU 52: [302977.009835] exe R running task 0 3972 60665 0x00000988 [302977.009838] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.009840] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.009842] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.009842] Call Trace: [302977.009847] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.009851] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009855] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009859] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009863] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009867] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009871] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009875] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.009879] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.009883] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.009900] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.009919] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.009920] [] ? recalc_sigpending+0x17/0x50 [302977.009937] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.009939] [] ? signal_setup_done+0x67/0xb0 [302977.009941] [] ? __seccomp_filter+0x74/0x270 [302977.009943] [] ? do_vfs_ioctl+0xa2/0x620 [302977.009946] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.009947] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.009949] [] ? SyS_ioctl+0x74/0x80 [302977.009951] [] ? do_syscall_64+0x8d/0x100 [302977.009953] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009954] Task dump for CPU 59: [302977.009957] exe R running task 0 60695 60665 0x00000188 [302977.009959] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [302977.009961] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [302977.009963] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [302977.009963] Call Trace: [302977.009966] [] ? vfs_fallocate+0x15a/0x220 [302977.009969] [] ? SyS_fallocate+0x43/0x80 [302977.009970] [] ? do_syscall_64+0x8d/0x100 [302977.009972] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.009973] Task dump for CPU 60: [302977.009975] exe R running task 0 3983 60665 0x00000188 [302977.009978] 0000000000883fff 00003ffffffff000 0000000000884000 ffffff8000000000 [302977.009980] 0000008000000000 0000000000883fff ffff9fc0b95f6000 0000000000884000 [302977.009982] 0000000000000287 0000000100000001 ffffba196a85fb40 0000000000000287 [302977.009982] Call Trace: [302977.010000] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.010002] [] ? __switch_to_asm+0x35/0x70 [302977.010004] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.010006] [] ? _raw_spin_lock+0x1d/0x20 [302977.010025] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.010029] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010047] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.010052] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010070] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010088] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010090] [] ? recalc_sigpending+0x17/0x50 [302977.010107] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010109] [] ? signal_setup_done+0x67/0xb0 [302977.010112] [] ? __seccomp_filter+0x74/0x270 [302977.010114] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010116] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010118] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010120] [] ? SyS_ioctl+0x74/0x80 [302977.010122] [] ? do_syscall_64+0x8d/0x100 [302977.010125] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010127] Task dump for CPU 0: [302977.010130] exe R running task 0 9806 60665 0x00000988 [302977.010133] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.010135] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.010137] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.010137] Call Trace: [302977.010144] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010147] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010151] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010154] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010157] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010160] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010163] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010166] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010169] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010172] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.010190] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010205] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302977.010207] [] ? recalc_sigpending+0x17/0x50 [302977.010221] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010223] [] ? signal_setup_done+0x67/0xb0 [302977.010225] [] ? __seccomp_filter+0x74/0x270 [302977.010227] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010229] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010230] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010232] [] ? SyS_ioctl+0x74/0x80 [302977.010234] [] ? do_syscall_64+0x8d/0x100 [302977.010236] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010237] Task dump for CPU 8: [302977.010239] exe R running task 0 4291 60665 0x00000188 [302977.010240] ffffffffa1b19a00 ffffffffa0ea953b 0000000000000008 ffffffffa1b19a00 [302977.010242] ffffffffa0f830ad ffff9fca868196c0 ffffffffa1a4fd80 0000000000000000 [302977.010244] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002ac840a [302977.010244] Call Trace: [302977.010247] [302977.010247] [] ? sched_show_task+0xcb/0x130 [302977.010249] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [302977.010252] [] ? rcu_check_callbacks+0x75a/0x8b0 [302977.010254] [] ? tick_sched_do_timer+0x30/0x30 [302977.010255] [] ? update_process_times+0x28/0x50 [302977.010257] [] ? tick_sched_handle.isra.12+0x20/0x50 [302977.010259] [] ? tick_sched_timer+0x38/0x70 [302977.010260] [] ? __hrtimer_run_queues+0xde/0x250 [302977.010262] [] ? hrtimer_interrupt+0x9c/0x1a0 [302977.010264] [] ? smp_apic_timer_interrupt+0x47/0x60 [302977.010266] [] ? apic_timer_interrupt+0x9e/0xb0 [302977.010268] [302977.010268] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.010270] [] ? _raw_spin_lock+0x1d/0x20 [302977.010285] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.010288] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010308] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.010313] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010327] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010342] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010343] [] ? recalc_sigpending+0x17/0x50 [302977.010355] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010357] [] ? signal_setup_done+0x67/0xb0 [302977.010359] [] ? __seccomp_filter+0x74/0x270 [302977.010360] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010362] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010364] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010366] [] ? SyS_ioctl+0x74/0x80 [302977.010367] [] ? do_syscall_64+0x8d/0x100 [302977.010369] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010370] Task dump for CPU 9: [302977.010372] exe R running task 0 4036 60665 0x00000988 [302977.010374] ffffffffa0ec6ef1 0000000000000010 0000000000000202 ffffba196ab7fbf0 [302977.010375] 0000000000000018 ffffffffa141e2fd ffffffffc0908f1b ffffba196ab7fc27 [302977.010377] ffffffffc09cf00c 0000000100000000 000000000001d0d8 0001ffffc09cf018 [302977.010377] Call Trace: [302977.010379] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.010381] [] ? _raw_spin_lock+0x1d/0x20 [302977.010395] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.010398] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010412] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.010416] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010430] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010443] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010445] [] ? recalc_sigpending+0x17/0x50 [302977.010457] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010459] [] ? signal_setup_done+0x67/0xb0 [302977.010461] [] ? __seccomp_filter+0x74/0x270 [302977.010462] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010464] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010466] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010467] [] ? SyS_ioctl+0x74/0x80 [302977.010469] [] ? do_syscall_64+0x8d/0x100 [302977.010471] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010472] Task dump for CPU 17: [302977.010473] exe R running task 0 60696 60665 0x00000988 [302977.010475] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.010477] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.010478] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.010479] Call Trace: [302977.010482] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010485] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010488] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010491] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010494] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010497] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010500] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010503] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010506] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010509] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.010522] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010536] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010537] [] ? recalc_sigpending+0x17/0x50 [302977.010553] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010555] [] ? signal_setup_done+0x67/0xb0 [302977.010556] [] ? __seccomp_filter+0x74/0x270 [302977.010558] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010560] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010562] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010564] [] ? SyS_ioctl+0x74/0x80 [302977.010565] [] ? do_syscall_64+0x8d/0x100 [302977.010567] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010568] Task dump for CPU 20: [302977.010570] exe R running task 0 60724 60665 0x00000988 [302977.010572] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.010573] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.010575] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.010575] Call Trace: [302977.010578] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010581] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010584] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010587] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010590] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010593] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010596] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010599] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010602] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010605] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.010619] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010633] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302977.010634] [] ? recalc_sigpending+0x17/0x50 [302977.010647] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010648] [] ? signal_setup_done+0x67/0xb0 [302977.010650] [] ? __seccomp_filter+0x74/0x270 [302977.010651] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010653] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010655] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010656] [] ? SyS_ioctl+0x74/0x80 [302977.010658] [] ? do_syscall_64+0x8d/0x100 [302977.010659] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010660] Task dump for CPU 32: [302977.010662] exe R running task 0 4116 60665 0x00000988 [302977.010664] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302977.010666] ffffba196b057de8 ffff9fbd40012000 0000000000000000 0000000000000000 [302977.010667] 0000000000000000 0000000000000000 ffff9faff3c3d140 0002799b30d258e5 [302977.010667] Call Trace: [302977.010671] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010688] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010702] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010703] [] ? recalc_sigpending+0x17/0x50 [302977.010715] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010717] [] ? signal_setup_done+0x67/0xb0 [302977.010718] [] ? __seccomp_filter+0x74/0x270 [302977.010720] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010722] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010723] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010725] [] ? SyS_ioctl+0x74/0x80 [302977.010726] [] ? do_syscall_64+0x8d/0x100 [302977.010728] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010729] Task dump for CPU 33: [302977.010730] exe R running task 0 4112 60665 0x00000988 [302977.010733] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.010735] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.010736] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.010737] Call Trace: [302977.010740] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010743] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010746] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010749] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010752] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010755] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010758] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010761] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.010764] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010767] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.010780] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010793] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010795] [] ? recalc_sigpending+0x17/0x50 [302977.010807] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010808] [] ? signal_setup_done+0x67/0xb0 [302977.010810] [] ? __seccomp_filter+0x74/0x270 [302977.010812] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010813] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010815] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010816] [] ? SyS_ioctl+0x74/0x80 [302977.010818] [] ? do_syscall_64+0x8d/0x100 [302977.010820] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010820] Task dump for CPU 42: [302977.010822] exe R running task 0 4000 60665 0x00000988 [302977.010824] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302977.010825] ffffba196a92fde8 ffff9fb24e339e80 0000000000000000 0000000000000000 [302977.010827] 0000000000000000 0000000000000000 ffff9faf3bf48000 0002799b31d950a2 [302977.010827] Call Trace: [302977.010830] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010843] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010857] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010858] [] ? recalc_sigpending+0x17/0x50 [302977.010870] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010872] [] ? signal_setup_done+0x67/0xb0 [302977.010873] [] ? __seccomp_filter+0x74/0x270 [302977.010875] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010877] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010878] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010880] [] ? SyS_ioctl+0x74/0x80 [302977.010881] [] ? do_syscall_64+0x8d/0x100 [302977.010883] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010884] Task dump for CPU 45: [302977.010886] exe R running task 0 9811 60665 0x00000188 [302977.010887] 0000000000785fff 00003ffffffff000 0000000000786000 ffffff8000000000 [302977.010889] 0000008000000000 0000000000785fff ffff9fc0b95f6000 0000000000786000 [302977.010891] 0000000000000287 00000001a0e526f6 ffffba197bd07b40 0000000000000287 [302977.010891] Call Trace: [302977.010904] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.010906] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.010907] [] ? _raw_spin_lock+0x1d/0x20 [302977.010922] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.010925] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.010938] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.010942] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.010956] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.010969] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.010971] [] ? recalc_sigpending+0x17/0x50 [302977.010983] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.010985] [] ? signal_setup_done+0x67/0xb0 [302977.010986] [] ? __seccomp_filter+0x74/0x270 [302977.010988] [] ? do_vfs_ioctl+0xa2/0x620 [302977.010990] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.010992] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.010993] [] ? SyS_ioctl+0x74/0x80 [302977.010995] [] ? do_syscall_64+0x8d/0x100 [302977.010996] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.010997] Task dump for CPU 52: [302977.010999] exe R running task 0 3972 60665 0x00000988 [302977.011001] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.011002] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.011004] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.011004] Call Trace: [302977.011008] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011011] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011014] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011016] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011019] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011022] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011025] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011028] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011031] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011034] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.011047] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011060] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.011062] [] ? recalc_sigpending+0x17/0x50 [302977.011074] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011075] [] ? signal_setup_done+0x67/0xb0 [302977.011077] [] ? __seccomp_filter+0x74/0x270 [302977.011079] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011080] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011082] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011083] [] ? SyS_ioctl+0x74/0x80 [302977.011085] [] ? do_syscall_64+0x8d/0x100 [302977.011087] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011087] Task dump for CPU 59: [302977.011089] exe R running task 0 60695 60665 0x00000188 [302977.011091] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [302977.011093] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [302977.011094] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [302977.011094] Call Trace: [302977.011097] [] ? vfs_fallocate+0x15a/0x220 [302977.011098] [] ? SyS_fallocate+0x43/0x80 [302977.011100] [] ? do_syscall_64+0x8d/0x100 [302977.011102] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011102] Task dump for CPU 60: [302977.011104] exe R running task 0 3983 60665 0x00000188 [302977.011106] 0000000000883fff 00003ffffffff000 0000000000884000 ffffff8000000000 [302977.011107] 0000008000000000 0000000000883fff ffff9fc0b95f6000 0000000000884000 [302977.011109] 0000000000000287 0000000100000001 ffffba196a85fb40 0000000000000287 [302977.011109] Call Trace: [302977.011122] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.011125] [] ? __switch_to_asm+0x35/0x70 [302977.011127] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.011128] [] ? _raw_spin_lock+0x1d/0x20 [302977.011142] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.011145] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011159] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.011163] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011176] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011191] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.011193] [] ? recalc_sigpending+0x17/0x50 [302977.011205] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011207] [] ? signal_setup_done+0x67/0xb0 [302977.011208] [] ? __seccomp_filter+0x74/0x270 [302977.011210] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011211] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011213] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011215] [] ? SyS_ioctl+0x74/0x80 [302977.011216] [] ? do_syscall_64+0x8d/0x100 [302977.011218] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011220] Task dump for CPU 0: [302977.011223] exe R running task 0 9806 60665 0x00000988 [302977.011227] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.011229] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.011231] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.011231] Call Trace: [302977.011240] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011244] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011248] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011252] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011256] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011259] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011263] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011267] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011271] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011276] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.011297] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011316] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302977.011319] [] ? recalc_sigpending+0x17/0x50 [302977.011336] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011338] [] ? signal_setup_done+0x67/0xb0 [302977.011341] [] ? __seccomp_filter+0x74/0x270 [302977.011343] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011346] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011348] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011350] [] ? SyS_ioctl+0x74/0x80 [302977.011352] [] ? do_syscall_64+0x8d/0x100 [302977.011354] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011355] Task dump for CPU 8: [302977.011359] exe R running task 0 4291 60665 0x00000188 [302977.011361] 00000000007ccfff 00003ffffffff000 00000000007cd000 ffffff8000000000 [302977.011363] 0000008000000000 00000000007ccfff ffff9fc0b95f6000 00000000007cd000 [302977.011365] 0000000000000287 00000001000fe000 ffffba196b5f7b40 0000000000000287 [302977.011366] Call Trace: [302977.011384] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.011386] [] ? entry_SYSCALL_64_after_swapgs+0x8a/0xc6 [302977.011388] [] ? __switch_to_asm+0x35/0x70 [302977.011390] [] ? __switch_to_asm+0x41/0x70 [302977.011392] [] ? __switch_to_asm+0x35/0x70 [302977.011395] [] ? __switch_to_asm+0x35/0x70 [302977.011397] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.011399] [] ? _raw_spin_lock+0x1d/0x20 [302977.011419] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.011423] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011443] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.011447] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011466] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011486] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.011487] [] ? recalc_sigpending+0x17/0x50 [302977.011505] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011507] [] ? signal_setup_done+0x67/0xb0 [302977.011509] [] ? __seccomp_filter+0x74/0x270 [302977.011511] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011514] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011516] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011518] [] ? SyS_ioctl+0x74/0x80 [302977.011520] [] ? do_syscall_64+0x8d/0x100 [302977.011522] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011523] Task dump for CPU 9: [302977.011525] exe R running task 0 4036 60665 0x00000988 [302977.011527] ffffffffa0ec6ef1 0000000000000010 0000000000000202 ffffba196ab7fbf0 [302977.011530] 0000000000000018 ffffffffa141e2fd ffffffffc0908f1b ffffba196ab7fc27 [302977.011532] ffffffffc09cf00c 0000000100000000 000000000001d0d8 0001ffffc09cf018 [302977.011532] Call Trace: [302977.011534] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.011536] [] ? _raw_spin_lock+0x1d/0x20 [302977.011555] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.011559] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011578] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.011583] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011601] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011620] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.011621] [] ? recalc_sigpending+0x17/0x50 [302977.011639] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011641] [] ? signal_setup_done+0x67/0xb0 [302977.011643] [] ? __seccomp_filter+0x74/0x270 [302977.011645] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011647] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011649] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011651] [] ? SyS_ioctl+0x74/0x80 [302977.011653] [] ? do_syscall_64+0x8d/0x100 [302977.011655] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011656] Task dump for CPU 17: [302977.011659] exe R running task 0 60696 60665 0x00000988 [302977.011661] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.011663] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.011665] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.011666] Call Trace: [302977.011670] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011674] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011678] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011682] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011686] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011690] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011694] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011698] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011702] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011706] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.011724] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011743] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.011745] [] ? recalc_sigpending+0x17/0x50 [302977.011762] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011764] [] ? signal_setup_done+0x67/0xb0 [302977.011766] [] ? __seccomp_filter+0x74/0x270 [302977.011768] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011770] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011772] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011774] [] ? SyS_ioctl+0x74/0x80 [302977.011776] [] ? do_syscall_64+0x8d/0x100 [302977.011778] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011779] Task dump for CPU 20: [302977.011781] exe R running task 0 60724 60665 0x00000988 [302977.011783] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.011785] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.011788] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.011788] Call Trace: [302977.011792] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011796] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011800] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011804] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011808] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011812] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011816] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011820] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.011823] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.011828] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.011846] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011870] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302977.011872] [] ? recalc_sigpending+0x17/0x50 [302977.011889] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011891] [] ? signal_setup_done+0x67/0xb0 [302977.011893] [] ? __seccomp_filter+0x74/0x270 [302977.011895] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011897] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011899] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011901] [] ? SyS_ioctl+0x74/0x80 [302977.011903] [] ? do_syscall_64+0x8d/0x100 [302977.011905] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011906] Task dump for CPU 32: [302977.011908] exe R running task 0 4116 60665 0x00000988 [302977.011911] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302977.011913] ffffba196b057de8 ffff9fbd40012000 0000000000000000 0000000000000000 [302977.011915] 0000000000000000 0000000000000000 ffff9faff3c3d140 0002799b30d258e5 [302977.011915] Call Trace: [302977.011919] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.011938] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.011956] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.011957] [] ? recalc_sigpending+0x17/0x50 [302977.011975] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.011976] [] ? signal_setup_done+0x67/0xb0 [302977.011978] [] ? __seccomp_filter+0x74/0x270 [302977.011980] [] ? do_vfs_ioctl+0xa2/0x620 [302977.011983] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.011985] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.011987] [] ? SyS_ioctl+0x74/0x80 [302977.011989] [] ? do_syscall_64+0x8d/0x100 [302977.011992] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.011993] Task dump for CPU 33: [302977.011995] exe R running task 0 4112 60665 0x00000988 [302977.011997] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.011999] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.012002] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.012002] Call Trace: [302977.012006] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012010] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012014] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012018] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012022] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012026] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012030] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012034] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012038] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012042] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.012060] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012078] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012079] [] ? recalc_sigpending+0x17/0x50 [302977.012096] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012098] [] ? signal_setup_done+0x67/0xb0 [302977.012100] [] ? __seccomp_filter+0x74/0x270 [302977.012102] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012104] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012106] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012108] [] ? SyS_ioctl+0x74/0x80 [302977.012110] [] ? do_syscall_64+0x8d/0x100 [302977.012112] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012113] Task dump for CPU 42: [302977.012115] exe R running task 0 4000 60665 0x00000988 [302977.012117] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302977.012119] ffffba196a92fde8 ffff9fb24e339e80 0000000000000000 0000000000000000 [302977.012121] 0000000000000000 0000000000000000 ffff9faf3bf48000 0002799b31d950a2 [302977.012122] Call Trace: [302977.012126] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012144] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012162] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012164] [] ? recalc_sigpending+0x17/0x50 [302977.012181] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012183] [] ? signal_setup_done+0x67/0xb0 [302977.012185] [] ? __seccomp_filter+0x74/0x270 [302977.012187] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012189] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012191] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012193] [] ? SyS_ioctl+0x74/0x80 [302977.012195] [] ? do_syscall_64+0x8d/0x100 [302977.012197] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012198] Task dump for CPU 45: [302977.012199] exe R running task 0 9811 60665 0x00000188 [302977.012202] ffffffffa1b19a00 ffffffffa0ea953b 000000000000002d ffffffffa1b19a00 [302977.012204] ffffffffa0f830ad ffff9fca871596c0 ffffffffa1a4fd80 0000000000000000 [302977.012206] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002ac840a [302977.012206] Call Trace: [302977.012209] [302977.012210] [] ? sched_show_task+0xcb/0x130 [302977.012213] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [302977.012216] [] ? rcu_check_callbacks+0x75a/0x8b0 [302977.012219] [] ? tick_sched_do_timer+0x30/0x30 [302977.012221] [] ? update_process_times+0x28/0x50 [302977.012223] [] ? tick_sched_handle.isra.12+0x20/0x50 [302977.012225] [] ? tick_sched_timer+0x38/0x70 [302977.012227] [] ? __hrtimer_run_queues+0xde/0x250 [302977.012230] [] ? hrtimer_interrupt+0x9c/0x1a0 [302977.012232] [] ? smp_apic_timer_interrupt+0x47/0x60 [302977.012234] [] ? apic_timer_interrupt+0x9e/0xb0 [302977.012237] [302977.012237] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.012239] [] ? _raw_spin_lock+0x1d/0x20 [302977.012258] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.012262] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012281] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.012286] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012304] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012322] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012324] [] ? recalc_sigpending+0x17/0x50 [302977.012341] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012343] [] ? signal_setup_done+0x67/0xb0 [302977.012345] [] ? __seccomp_filter+0x74/0x270 [302977.012347] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012349] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012351] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012353] [] ? SyS_ioctl+0x74/0x80 [302977.012355] [] ? do_syscall_64+0x8d/0x100 [302977.012357] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012358] Task dump for CPU 52: [302977.012360] exe R running task 0 3972 60665 0x00000988 [302977.012362] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.012365] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.012367] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.012367] Call Trace: [302977.012372] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012376] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012380] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012383] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012387] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012391] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012395] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012399] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012403] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012407] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.012425] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012443] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012445] [] ? recalc_sigpending+0x17/0x50 [302977.012462] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012464] [] ? signal_setup_done+0x67/0xb0 [302977.012466] [] ? __seccomp_filter+0x74/0x270 [302977.012468] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012470] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012472] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012474] [] ? SyS_ioctl+0x74/0x80 [302977.012476] [] ? do_syscall_64+0x8d/0x100 [302977.012478] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012480] Task dump for CPU 59: [302977.012482] exe R running task 0 60695 60665 0x00000188 [302977.012485] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [302977.012487] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [302977.012489] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [302977.012489] Call Trace: [302977.012492] [] ? vfs_fallocate+0x15a/0x220 [302977.012494] [] ? SyS_fallocate+0x43/0x80 [302977.012496] [] ? do_syscall_64+0x8d/0x100 [302977.012498] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012499] Task dump for CPU 60: [302977.012501] exe R running task 0 3983 60665 0x00000188 [302977.012503] 0000000000883fff 00003ffffffff000 0000000000884000 ffffff8000000000 [302977.012505] 0000008000000000 0000000000883fff ffff9fc0b95f6000 0000000000884000 [302977.012508] 0000000000000287 0000000100000001 ffffba196a85fb40 0000000000000287 [302977.012508] Call Trace: [302977.012526] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.012528] [] ? __switch_to_asm+0x35/0x70 [302977.012530] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.012532] [] ? _raw_spin_lock+0x1d/0x20 [302977.012551] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.012555] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012573] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.012578] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012596] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012615] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012616] [] ? recalc_sigpending+0x17/0x50 [302977.012633] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012635] [] ? signal_setup_done+0x67/0xb0 [302977.012637] [] ? __seccomp_filter+0x74/0x270 [302977.012639] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012641] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012643] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012645] [] ? SyS_ioctl+0x74/0x80 [302977.012647] [] ? do_syscall_64+0x8d/0x100 [302977.012649] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012652] Task dump for CPU 0: [302977.012654] exe R running task 0 9806 60665 0x00000988 [302977.012657] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.012659] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.012660] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.012661] Call Trace: [302977.012667] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012670] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012672] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012674] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012677] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012679] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012681] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012684] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012686] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012689] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.012702] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012714] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302977.012716] [] ? recalc_sigpending+0x17/0x50 [302977.012725] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012727] [] ? signal_setup_done+0x67/0xb0 [302977.012729] [] ? __seccomp_filter+0x74/0x270 [302977.012731] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012733] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012735] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012737] [] ? SyS_ioctl+0x74/0x80 [302977.012738] [] ? do_syscall_64+0x8d/0x100 [302977.012740] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012741] Task dump for CPU 8: [302977.012743] exe R running task 0 4291 60665 0x00000188 [302977.012745] 00000000007ccfff 00003ffffffff000 00000000007cd000 ffffff8000000000 [302977.012747] 0000008000000000 00000000007ccfff ffff9fc0b95f6000 00000000007cd000 [302977.012748] 0000000000000287 00000001000fe000 ffffba196b5f7b40 0000000000000287 [302977.012748] Call Trace: [302977.012758] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.012760] [] ? entry_SYSCALL_64_after_swapgs+0x8a/0xc6 [302977.012762] [] ? __switch_to_asm+0x35/0x70 [302977.012763] [] ? __switch_to_asm+0x41/0x70 [302977.012765] [] ? __switch_to_asm+0x35/0x70 [302977.012766] [] ? __switch_to_asm+0x35/0x70 [302977.012768] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.012770] [] ? _raw_spin_lock+0x1d/0x20 [302977.012782] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.012785] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012796] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.012800] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012811] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012822] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012823] [] ? recalc_sigpending+0x17/0x50 [302977.012832] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012834] [] ? signal_setup_done+0x67/0xb0 [302977.012835] [] ? __seccomp_filter+0x74/0x270 [302977.012837] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012839] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012840] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012842] [] ? SyS_ioctl+0x74/0x80 [302977.012843] [] ? do_syscall_64+0x8d/0x100 [302977.012845] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012845] Task dump for CPU 9: [302977.012847] exe R running task 0 4036 60665 0x00000988 [302977.012849] ffffffffa0ec6ef1 0000000000000010 0000000000000202 ffffba196ab7fbf0 [302977.012850] 0000000000000018 ffffffffa141e2fd ffffffffc0908f1b ffffba196ab7fc27 [302977.012852] ffffffffc09cf00c 0000000100000000 000000000001d0d8 0001ffffc09cf018 [302977.012852] Call Trace: [302977.012853] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.012855] [] ? _raw_spin_lock+0x1d/0x20 [302977.012866] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.012869] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012880] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.012883] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012893] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012904] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012905] [] ? recalc_sigpending+0x17/0x50 [302977.012914] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012915] [] ? signal_setup_done+0x67/0xb0 [302977.012917] [] ? __seccomp_filter+0x74/0x270 [302977.012919] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012920] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012922] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012923] [] ? SyS_ioctl+0x74/0x80 [302977.012925] [] ? do_syscall_64+0x8d/0x100 [302977.012927] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.012928] Task dump for CPU 17: [302977.012930] exe R running task 0 60696 60665 0x00000988 [302977.012931] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.012933] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.012934] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.012934] Call Trace: [302977.012938] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.012940] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012942] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012945] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012947] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012949] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012951] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012954] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.012956] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.012959] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.012969] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.012979] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.012980] [] ? recalc_sigpending+0x17/0x50 [302977.012990] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.012992] [] ? signal_setup_done+0x67/0xb0 [302977.012993] [] ? __seccomp_filter+0x74/0x270 [302977.012995] [] ? do_vfs_ioctl+0xa2/0x620 [302977.012996] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.012998] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.012999] [] ? SyS_ioctl+0x74/0x80 [302977.013001] [] ? do_syscall_64+0x8d/0x100 [302977.013002] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013003] Task dump for CPU 20: [302977.013004] exe R running task 0 60724 60665 0x00000988 [302977.013006] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.013007] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.013009] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.013009] Call Trace: [302977.013012] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.013014] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013016] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013019] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013021] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013023] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013025] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013028] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013030] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013032] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.013042] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.013053] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302977.013054] [] ? recalc_sigpending+0x17/0x50 [302977.013062] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.013064] [] ? signal_setup_done+0x67/0xb0 [302977.013065] [] ? __seccomp_filter+0x74/0x270 [302977.013067] [] ? do_vfs_ioctl+0xa2/0x620 [302977.013068] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.013070] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.013071] [] ? SyS_ioctl+0x74/0x80 [302977.013073] [] ? do_syscall_64+0x8d/0x100 [302977.013075] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013076] Task dump for CPU 32: [302977.013078] exe R running task 0 4116 60665 0x00000988 [302977.013079] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302977.013081] ffffba196b057de8 ffff9fbd40012000 0000000000000000 0000000000000000 [302977.013082] 0000000000000000 0000000000000000 ffff9faff3c3d140 0002799b30d258e5 [302977.013082] Call Trace: [302977.013085] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.013095] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.013105] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.013107] [] ? recalc_sigpending+0x17/0x50 [302977.013115] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.013117] [] ? signal_setup_done+0x67/0xb0 [302977.013118] [] ? __seccomp_filter+0x74/0x270 [302977.013120] [] ? do_vfs_ioctl+0xa2/0x620 [302977.013121] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.013123] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.013124] [] ? SyS_ioctl+0x74/0x80 [302977.013125] [] ? do_syscall_64+0x8d/0x100 [302977.013127] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013128] Task dump for CPU 33: [302977.013129] exe R running task 0 4112 60665 0x00000988 [302977.013131] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.013132] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.013134] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.013134] Call Trace: [302977.013137] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.013139] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013141] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013143] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013146] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013148] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013150] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013152] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013155] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013157] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.013167] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.013177] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.013178] [] ? recalc_sigpending+0x17/0x50 [302977.013187] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.013188] [] ? signal_setup_done+0x67/0xb0 [302977.013189] [] ? __seccomp_filter+0x74/0x270 [302977.013191] [] ? do_vfs_ioctl+0xa2/0x620 [302977.013192] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.013194] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.013195] [] ? SyS_ioctl+0x74/0x80 [302977.013197] [] ? do_syscall_64+0x8d/0x100 [302977.013198] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013199] Task dump for CPU 42: [302977.013200] exe R running task 0 4000 60665 0x00000988 [302977.013202] ffffffffa1b19a00 ffffffffa0ea953b 000000000000002a ffffffffa1b19a00 [302977.013203] ffffffffa0f830ad ffff9fca870996c0 ffffffffa1a4fd80 0000000000000000 [302977.013205] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002ac848d [302977.013205] Call Trace: [302977.013207] [302977.013207] [] ? sched_show_task+0xcb/0x130 [302977.013209] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [302977.013212] [] ? rcu_check_callbacks+0x75a/0x8b0 [302977.013214] [] ? tick_sched_do_timer+0x30/0x30 [302977.013216] [] ? update_process_times+0x28/0x50 [302977.013217] [] ? tick_sched_handle.isra.12+0x20/0x50 [302977.013219] [] ? tick_sched_timer+0x38/0x70 [302977.013221] [] ? __hrtimer_run_queues+0xde/0x250 [302977.013222] [] ? hrtimer_interrupt+0x9c/0x1a0 [302977.013224] [] ? smp_apic_timer_interrupt+0x47/0x60 [302977.013226] [] ? apic_timer_interrupt+0x9e/0xb0 [302977.013228] [302977.013228] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.013234] [] ? _raw_spin_lock+0x1d/0x20 [302977.013245] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.013247] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013258] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.013261] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.013271] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.013281] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.013282] [] ? recalc_sigpending+0x17/0x50 [302977.013291] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.013292] [] ? signal_setup_done+0x67/0xb0 [302977.013294] [] ? __seccomp_filter+0x74/0x270 [302977.013296] [] ? do_vfs_ioctl+0xa2/0x620 [302977.013297] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.013299] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.013300] [] ? SyS_ioctl+0x74/0x80 [302977.013302] [] ? do_syscall_64+0x8d/0x100 [302977.013303] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013304] Task dump for CPU 45: [302977.013306] exe R running task 0 9811 60665 0x00000188 [302977.013307] 0000000000785fff 00003ffffffff000 0000000000786000 ffffff8000000000 [302977.013309] 0000008000000000 0000000000785fff ffff9fc0b95f6000 0000000000786000 [302977.013310] 0000000000000287 00000001a0e526f6 ffffba197bd07b40 0000000000000287 [302977.013310] Call Trace: [302977.013320] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.013321] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.013323] [] ? _raw_spin_lock+0x1d/0x20 [302977.013334] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.013336] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013347] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.013350] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.013359] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.013369] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.013371] [] ? recalc_sigpending+0x17/0x50 [302977.013379] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.013381] [] ? signal_setup_done+0x67/0xb0 [302977.013382] [] ? __seccomp_filter+0x74/0x270 [302977.013384] [] ? do_vfs_ioctl+0xa2/0x620 [302977.013385] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.013387] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.013388] [] ? SyS_ioctl+0x74/0x80 [302977.013390] [] ? do_syscall_64+0x8d/0x100 [302977.013391] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013392] Task dump for CPU 52: [302977.013393] exe R running task 0 3972 60665 0x00000988 [302977.013395] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302977.013396] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302977.013398] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302977.013398] Call Trace: [302977.013402] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.013404] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013407] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013409] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013412] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013414] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013416] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013419] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302977.013421] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013423] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302977.013433] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.013443] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.013444] [] ? recalc_sigpending+0x17/0x50 [302977.013453] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.013454] [] ? signal_setup_done+0x67/0xb0 [302977.013456] [] ? __seccomp_filter+0x74/0x270 [302977.013457] [] ? do_vfs_ioctl+0xa2/0x620 [302977.013459] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.013460] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.013462] [] ? SyS_ioctl+0x74/0x80 [302977.013463] [] ? do_syscall_64+0x8d/0x100 [302977.013465] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013465] Task dump for CPU 59: [302977.013467] exe R running task 0 60695 60665 0x00000188 [302977.013468] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [302977.013470] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [302977.013471] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [302977.013471] Call Trace: [302977.013474] [] ? vfs_fallocate+0x15a/0x220 [302977.013475] [] ? SyS_fallocate+0x43/0x80 [302977.013477] [] ? do_syscall_64+0x8d/0x100 [302977.013478] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302977.013479] Task dump for CPU 60: [302977.013480] exe R running task 0 3983 60665 0x00000188 [302977.013482] 0000000000883fff 00003ffffffff000 0000000000884000 ffffff8000000000 [302977.013483] 0000008000000000 0000000000883fff ffff9fc0b95f6000 0000000000884000 [302977.013485] 0000000000000287 0000000100000001 ffffba196a85fb40 0000000000000287 [302977.013485] Call Trace: [302977.013494] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302977.013496] [] ? __switch_to_asm+0x35/0x70 [302977.013498] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302977.013499] [] ? _raw_spin_lock+0x1d/0x20 [302977.013510] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302977.013512] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302977.013523] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302977.013526] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302977.013535] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302977.013546] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302977.013547] [] ? recalc_sigpending+0x17/0x50 [302977.013556] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302977.013557] [] ? signal_setup_done+0x67/0xb0 [302977.013559] [] ? __seccomp_filter+0x74/0x270 [302977.013560] [] ? do_vfs_ioctl+0xa2/0x620 [302977.013562] [] ? __audit_syscall_entry+0xaa/0xf0 [302977.013563] [] ? syscall_trace_enter+0x1ae/0x2c0 [302977.013565] [] ? SyS_ioctl+0x74/0x80 [302977.013566] [] ? do_syscall_64+0x8d/0x100 [302977.013568] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302995.175294] 60-...: (20999 ticks this GP) idle=1ed/140000000000001/0 softirq=33587045/33587045 fqs=10645 [302995.185173] (t=25550 jiffies g=12067405 c=12067404 q=95702) [302995.191242] Task dump for CPU 0: [302995.194678] exe R running task 0 9806 60665 0x00000988 [302995.202189] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302995.210300] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302995.218939] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302995.227822] Call Trace: [302995.230487] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302995.237743] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.244747] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.251661] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.258655] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.265557] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.272543] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.279444] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.286430] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.293337] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302995.300256] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302995.307689] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302995.314593] [] ? recalc_sigpending+0x17/0x50 [302995.320724] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302995.327294] [] ? signal_setup_done+0x67/0xb0 [302995.333413] [] ? __seccomp_filter+0x74/0x270 [302995.339530] [] ? do_vfs_ioctl+0xa2/0x620 [302995.345300] [] ? __audit_syscall_entry+0xaa/0xf0 [302995.351856] [] ? syscall_trace_enter+0x1ae/0x2c0 [302995.358339] [] ? SyS_ioctl+0x74/0x80 [302995.363760] [] ? do_syscall_64+0x8d/0x100 [302995.369625] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302995.377141] Task dump for CPU 8: [302995.380586] exe R running task 0 4291 60665 0x00000188 [302995.388082] 00000000007ccfff 00003ffffffff000 00000000007cd000 ffffff8000000000 [302995.396214] 0000008000000000 00000000007ccfff ffff9fc0b95f6000 00000000007cd000 [302995.404342] 0000000000000287 00000001000fe000 ffffba196b5f7b40 0000000000000287 [302995.412472] Call Trace: [302995.415151] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302995.422341] [] ? entry_SYSCALL_64_after_swapgs+0x8a/0xc6 [302995.429502] [] ? __switch_to_asm+0x35/0x70 [302995.435446] [] ? __switch_to_asm+0x41/0x70 [302995.441405] [] ? __switch_to_asm+0x35/0x70 [302995.447350] [] ? __switch_to_asm+0x35/0x70 [302995.453295] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302995.460814] [] ? _raw_spin_lock+0x1d/0x20 [302995.466711] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302995.473272] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.480194] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302995.487013] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302995.495146] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302995.502584] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302995.509399] [] ? recalc_sigpending+0x17/0x50 [302995.515532] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302995.522085] [] ? signal_setup_done+0x67/0xb0 [302995.528217] [] ? __seccomp_filter+0x74/0x270 [302995.534346] [] ? do_vfs_ioctl+0xa2/0x620 [302995.540125] [] ? __audit_syscall_entry+0xaa/0xf0 [302995.546594] [] ? syscall_trace_enter+0x1ae/0x2c0 [302995.553061] [] ? SyS_ioctl+0x74/0x80 [302995.558601] [] ? do_syscall_64+0x8d/0x100 [302995.565468] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302995.573517] Task dump for CPU 9: [302995.577032] exe R running task 0 4036 60665 0x00000988 [302995.584534] ffffffffa0ec6edf 0000000000000010 0000000000000202 ffffba196ab7fbf0 [302995.592636] 0000000000000018 ffffffffa141e2fd ffffffffc0908f1b ffffba196ab7fc27 [302995.600769] ffffffffc09cf00c 0000000100000000 000000000001d0d8 0001ffffc09cf018 [302995.608881] Call Trace: [302995.611683] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302995.619198] [] ? _raw_spin_lock+0x1d/0x20 [302995.625083] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302995.631645] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.638575] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302995.645486] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302995.652749] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302995.660599] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302995.667457] [] ? recalc_sigpending+0x17/0x50 [302995.673599] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302995.680154] [] ? signal_setup_done+0x67/0xb0 [302995.686297] [] ? __seccomp_filter+0x74/0x270 [302995.692423] [] ? do_vfs_ioctl+0xa2/0x620 [302995.698194] [] ? __audit_syscall_entry+0xaa/0xf0 [302995.704659] [] ? syscall_trace_enter+0x1ae/0x2c0 [302995.711125] [] ? SyS_ioctl+0x74/0x80 [302995.716659] [] ? do_syscall_64+0x8d/0x100 [302995.722522] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302995.729682] Task dump for CPU 17: [302995.733196] exe R running task 0 60696 60665 0x00000988 [302995.740776] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302995.748896] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302995.756999] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302995.765119] Call Trace: [302995.767777] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302995.775033] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.782025] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.788927] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.795932] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.802849] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.809844] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.816861] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.823849] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.830772] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302995.837782] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302995.845353] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302995.852345] [] ? recalc_sigpending+0x17/0x50 [302995.858506] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302995.865162] [] ? signal_setup_done+0x67/0xb0 [302995.871293] [] ? __seccomp_filter+0x74/0x270 [302995.877410] [] ? do_vfs_ioctl+0xa2/0x620 [302995.883178] [] ? __audit_syscall_entry+0xaa/0xf0 [302995.889641] [] ? syscall_trace_enter+0x1ae/0x2c0 [302995.896105] [] ? SyS_ioctl+0x74/0x80 [302995.901536] [] ? do_syscall_64+0x8d/0x100 [302995.907399] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302995.914568] Task dump for CPU 20: [302995.918082] exe R running task 0 60724 60665 0x00000988 [302995.925587] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302995.933695] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302995.941814] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302995.949919] Call Trace: [302995.952574] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302995.959835] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.966827] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.973726] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.980716] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302995.987616] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302995.995048] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.001960] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.008946] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.015860] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302996.022792] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302996.030252] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [302996.037165] [] ? recalc_sigpending+0x17/0x50 [302996.043308] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302996.049881] [] ? signal_setup_done+0x67/0xb0 [302996.056002] [] ? __seccomp_filter+0x74/0x270 [302996.062121] [] ? do_vfs_ioctl+0xa2/0x620 [302996.067892] [] ? __audit_syscall_entry+0xaa/0xf0 [302996.074358] [] ? syscall_trace_enter+0x1ae/0x2c0 [302996.080833] [] ? SyS_ioctl+0x74/0x80 [302996.086258] [] ? do_syscall_64+0x8d/0x100 [302996.092128] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302996.099298] Task dump for CPU 32: [302996.102818] exe R running task 0 4116 60665 0x00000988 [302996.110327] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302996.118437] ffffba196b057de8 ffff9fbd40012000 0000000000000000 0000000000000000 [302996.126535] 0000000000000000 0000000000000000 ffff9faff3c3d140 0002799b30d258e5 [302996.134633] Call Trace: [302996.137288] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302996.144568] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302996.152000] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302996.158930] [] ? recalc_sigpending+0x17/0x50 [302996.165068] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302996.171631] [] ? signal_setup_done+0x67/0xb0 [302996.177749] [] ? __seccomp_filter+0x74/0x270 [302996.183878] [] ? do_vfs_ioctl+0xa2/0x620 [302996.189998] [] ? __audit_syscall_entry+0xaa/0xf0 [302996.196480] [] ? syscall_trace_enter+0x1ae/0x2c0 [302996.202945] [] ? SyS_ioctl+0x74/0x80 [302996.208369] [] ? do_syscall_64+0x8d/0x100 [302996.214226] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302996.221384] Task dump for CPU 33: [302996.224900] exe R running task 0 4112 60665 0x00000988 [302996.232414] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302996.240511] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302996.248910] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302996.256994] Call Trace: [302996.259644] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302996.266892] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.273966] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.280865] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.287855] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.295365] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.302354] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.309269] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.316267] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.324046] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302996.331051] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302996.338484] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302996.345340] [] ? recalc_sigpending+0x17/0x50 [302996.351477] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302996.358033] [] ? signal_setup_done+0x67/0xb0 [302996.364153] [] ? __seccomp_filter+0x74/0x270 [302996.370282] [] ? do_vfs_ioctl+0xa2/0x620 [302996.376053] [] ? __audit_syscall_entry+0xaa/0xf0 [302996.382532] [] ? syscall_trace_enter+0x1ae/0x2c0 [302996.388994] [] ? SyS_ioctl+0x74/0x80 [302996.394435] [] ? do_syscall_64+0x8d/0x100 [302996.400292] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302996.407453] Task dump for CPU 42: [302996.410970] exe R running task 0 4000 60665 0x00000988 [302996.418472] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [302996.427205] ffffba196a92fde8 ffff9fb24e339e80 0000000000000000 0000000000000000 [302996.435309] 0000000000000000 0000000000000000 ffff9faf3bf48000 0002799b31d950a2 [302996.443505] Call Trace: [302996.446169] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302996.453444] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302996.460889] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302996.467898] [] ? recalc_sigpending+0x17/0x50 [302996.474045] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302996.480598] [] ? signal_setup_done+0x67/0xb0 [302996.486731] [] ? __seccomp_filter+0x74/0x270 [302996.492846] [] ? do_vfs_ioctl+0xa2/0x620 [302996.498621] [] ? __audit_syscall_entry+0xaa/0xf0 [302996.505187] [] ? syscall_trace_enter+0x1ae/0x2c0 [302996.511663] [] ? SyS_ioctl+0x74/0x80 [302996.517099] [] ? do_syscall_64+0x8d/0x100 [302996.522957] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302996.530128] Task dump for CPU 45: [302996.533637] exe R running task 0 9811 60665 0x00000188 [302996.541561] 0000000000785fff 00003ffffffff000 0000000000786000 ffffff8000000000 [302996.549713] 0000008000000000 0000000000785fff ffff9fc0b95f6000 0000000000786000 [302996.557800] 0000000000000287 00000001a0e526f6 ffffba197bd07b40 0000000000000287 [302996.565907] Call Trace: [302996.568574] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [302996.575646] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302996.583151] [] ? _raw_spin_lock+0x1d/0x20 [302996.589022] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302996.595576] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.602503] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302996.609315] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302996.616585] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302996.624016] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302996.630827] [] ? recalc_sigpending+0x17/0x50 [302996.636959] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302996.643625] [] ? signal_setup_done+0x67/0xb0 [302996.649747] [] ? __seccomp_filter+0x74/0x270 [302996.655876] [] ? do_vfs_ioctl+0xa2/0x620 [302996.661646] [] ? __audit_syscall_entry+0xaa/0xf0 [302996.668111] [] ? syscall_trace_enter+0x1ae/0x2c0 [302996.674585] [] ? SyS_ioctl+0x74/0x80 [302996.680006] [] ? do_syscall_64+0x8d/0x100 [302996.685877] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302996.693041] Task dump for CPU 52: [302996.696557] exe R running task 0 3972 60665 0x00000988 [302996.704074] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [302996.712199] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [302996.720310] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [302996.728401] Call Trace: [302996.731053] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302996.738300] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.745312] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.752384] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.759370] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.766279] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.773272] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.780178] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [302996.787166] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302996.794064] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [302996.800988] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302996.808420] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302996.815231] [] ? recalc_sigpending+0x17/0x50 [302996.821367] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302996.827920] [] ? signal_setup_done+0x67/0xb0 [302996.834052] [] ? __seccomp_filter+0x74/0x270 [302996.840181] [] ? do_vfs_ioctl+0xa2/0x620 [302996.845970] [] ? __audit_syscall_entry+0xaa/0xf0 [302996.853583] [] ? syscall_trace_enter+0x1ae/0x2c0 [302996.860076] [] ? SyS_ioctl+0x74/0x80 [302996.865500] [] ? do_syscall_64+0x8d/0x100 [302996.871362] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302996.878611] Task dump for CPU 59: [302996.882125] exe R running task 0 60695 60665 0x00000188 [302996.889727] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [302996.897834] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [302996.906530] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [302996.914654] Call Trace: [302996.917439] [] ? vfs_fallocate+0x15a/0x220 [302996.923396] [] ? SyS_fallocate+0x43/0x80 [302996.929380] [] ? do_syscall_64+0x8d/0x100 [302996.935238] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [302996.942397] Task dump for CPU 60: [302996.945907] exe R running task 0 3983 60665 0x00000188 [302996.953420] ffffffffa1b19a00 ffffffffa0ea953b 000000000000003c ffffffffa1b19a00 [302996.961504] ffffffffa0f830ad ffff9fca875196c0 ffffffffa1a4fd80 0000000000000000 [302996.969608] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002bb80c3 [302996.978223] Call Trace: [302996.980981] [302996.983133] [] ? sched_show_task+0xcb/0x130 [302996.989542] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [302996.995849] [] ? rcu_check_callbacks+0x75a/0x8b0 [302997.002331] [] ? tick_sched_do_timer+0x30/0x30 [302997.008838] [] ? update_process_times+0x28/0x50 [302997.015233] [] ? tick_sched_handle.isra.12+0x20/0x50 [302997.022169] [] ? tick_sched_timer+0x38/0x70 [302997.028198] [] ? __hrtimer_run_queues+0xde/0x250 [302997.035193] [] ? hrtimer_interrupt+0x9c/0x1a0 [302997.041533] [] ? smp_apic_timer_interrupt+0x47/0x60 [302997.048261] [] ? apic_timer_interrupt+0x9e/0xb0 [302997.054637] [302997.056778] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [302997.064320] [] ? _raw_spin_lock+0x1d/0x20 [302997.070598] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [302997.077291] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [302997.084212] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [302997.091024] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [302997.098287] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [302997.105916] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [302997.112908] [] ? recalc_sigpending+0x17/0x50 [302997.119062] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [302997.125616] [] ? signal_setup_done+0x67/0xb0 [302997.132006] [] ? __seccomp_filter+0x74/0x270 [302997.138322] [] ? do_vfs_ioctl+0xa2/0x620 [302997.144093] [] ? __audit_syscall_entry+0xaa/0xf0 [302997.150564] [] ? syscall_trace_enter+0x1ae/0x2c0 [302997.157466] [] ? SyS_ioctl+0x74/0x80 [302997.162889] [] ? do_syscall_64+0x8d/0x100 [302997.168754] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303003.231680] audit: audit_backlog=321 > audit_backlog_limit=320 [303003.231686] audit: audit_backlog=321 > audit_backlog_limit=320 [303003.231688] audit: audit_lost=116 audit_rate_limit=0 audit_backlog_limit=320 [303003.231690] audit: backlog limit exceeded [303003.231705] audit: audit_backlog=321 > audit_backlog_limit=320 [303003.231707] audit: audit_lost=117 audit_rate_limit=0 audit_backlog_limit=320 [303003.231707] audit: backlog limit exceeded [303003.231730] audit: audit_backlog=321 > audit_backlog_limit=320 [303003.231732] audit: audit_lost=118 audit_rate_limit=0 audit_backlog_limit=320 [303003.231733] audit: backlog limit exceeded [303008.655079] audit_log_start: 1109 callbacks suppressed [303008.655081] audit: audit_backlog=321 > audit_backlog_limit=320 [303008.655420] audit: audit_backlog=321 > audit_backlog_limit=320 [303008.655425] audit: audit_lost=489 audit_rate_limit=0 audit_backlog_limit=320 [303008.655426] audit: backlog limit exceeded [303008.682674] audit: audit_backlog=321 > audit_backlog_limit=320 [303008.682676] audit: audit_lost=490 audit_rate_limit=0 audit_backlog_limit=320 [303008.682677] audit: backlog limit exceeded [303008.685960] audit: audit_backlog=321 > audit_backlog_limit=320 [303008.685962] audit: audit_lost=491 audit_rate_limit=0 audit_backlog_limit=320 [303008.685963] audit: backlog limit exceeded [303015.001774] audit_log_start: 269 callbacks suppressed [303015.001776] audit: audit_backlog=321 > audit_backlog_limit=320 [303015.015280] audit: audit_lost=582 audit_rate_limit=0 audit_backlog_limit=320 [303015.023934] audit: backlog limit exceeded [303015.043545] audit: audit_backlog=321 > audit_backlog_limit=320 [303015.051085] audit: audit_lost=583 audit_rate_limit=0 audit_backlog_limit=320 [303015.059858] audit: backlog limit exceeded [303015.067440] audit: audit_backlog=321 > audit_backlog_limit=320 [303015.074417] audit: audit_lost=584 audit_rate_limit=0 audit_backlog_limit=320 [303015.083091] audit: backlog limit exceeded [303015.100388] audit: audit_backlog=321 > audit_backlog_limit=320 [303019.614366] INFO: task auditd:1136 blocked for more than 120 seconds. [303019.621054] Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303019.629150] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [303019.638619] auditd D 0 1136 1 0x00000000 [303019.647224] 0000000000000086 ffff9fca6f560000 ffff9fb275dc9400 ffff9fca737dd140 [303019.658308] ffff9fca86f58980 ffff9fbf4bb9c140 ffffba194e13fe48 ffffffffa1419609 [303019.675313] ffff9fca71f4d0a0 0000000000000246 ffff9fca86f58980 ffff9fca71f4d088 [303019.687793] Call Trace: [303019.690469] [] ? __schedule+0x239/0x6f0 [303019.696177] [] ? schedule+0x32/0x80 [303019.702944] [] ? jbd2_log_wait_commit+0x93/0x110 [jbd2] [303019.711768] [] ? prepare_to_wait_event+0xf0/0xf0 [303019.718378] [] ? ext4_sync_file+0x1ab/0x380 [ext4] [303019.726551] [] ? do_fsync+0x38/0x60 [303019.733331] [] ? SyS_fsync+0xc/0x10 [303019.740191] [] ? do_syscall_64+0x8d/0x100 [303019.747472] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303019.756655] INFO: task kworker/u128:2:19899 blocked for more than 120 seconds. [303019.765096] Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303019.775202] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [303019.784637] kworker/u128:2 D 0 19899 2 0x00000080 [303019.793269] Workqueue: netns cleanup_net [303019.798938] 0000000000000046 ffff9fb3551cbc00 ffff9fca75e45400 ffff9fc0fb488100 [303019.809887] ffff9fca874d8980 ffff9fc3011050c0 ffffba196bd2fc20 ffffffffa1419609 [303019.822254] 000000000b200038 00ffffffa0ee9134 ffff9fca874d8980 ffffffffa1ade520 [303019.834630] Call Trace: [303019.838843] [] ? __schedule+0x239/0x6f0 [303019.845953] [] ? schedule+0x32/0x80 [303019.852926] [] ? schedule_timeout+0x1dd/0x380 [303019.860712] [] ? release_nodes+0x106/0x200 [303019.866700] [] ? device_release+0x30/0x90 [303019.874522] [] ? wait_for_completion+0xf1/0x130 [303019.882311] [] ? wake_up_q+0x70/0x70 [303019.887789] [] ? __wait_rcu_gp+0xc2/0xf0 [303019.895064] [] ? synchronize_sched+0x59/0x80 [303019.901674] [] ? call_rcu_bh+0x20/0x20 [303019.909035] [] ? trace_raw_output_rcu_utilization+0x60/0x60 [303019.918378] [] ? nfnetlink_net_exit_batch+0x33/0x60 [nfnetlink] [303019.927128] [] ? cleanup_net+0x1c7/0x2b0 [303019.934323] [] ? process_one_work+0x18a/0x430 [303019.941965] [] ? worker_thread+0x4d/0x490 [303019.949633] [] ? process_one_work+0x430/0x430 [303019.955989] [] ? kthread+0xd9/0xf0 [303019.963736] [] ? __switch_to_asm+0x41/0x70 [303019.971491] [] ? kthread_park+0x60/0x60 [303019.978614] [] ? ret_from_fork+0x57/0x70 [303019.985758] INFO: task kworker/61:1:47571 blocked for more than 120 seconds. [303019.994397] Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303020.003912] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [303020.013346] kworker/61:1 D 0 47571 2 0x00000080 [303020.021971] Workqueue: events proc_cleanup_work [303020.030074] 0000000000000046 ffff9fc0f3ac8c00 ffff9fc0f3ac8c00 ffff9fc397b5d0c0 [303020.042412] ffff9fca87558980 ffff9fb2ad7e30c0 ffffba195d5d7c90 ffffffffa1419609 [303020.055772] 0000000000000002 0000000000000000 ffff9fca87558980 aec3b362d448ba9a [303020.066935] Call Trace: [303020.070992] [] ? __schedule+0x239/0x6f0 [303020.078172] [] ? schedule+0x32/0x80 [303020.083549] [] ? schedule_timeout+0x1dd/0x380 [303020.091153] [] ? unmap_pmd_range+0x1fa/0x230 [303020.098675] [] ? __switch_to_asm+0x41/0x70 [303020.106042] [] ? __switch_to_asm+0x35/0x70 [303020.114078] [] ? wait_for_completion+0xf1/0x130 [303020.122833] [] ? wake_up_q+0x70/0x70 [303020.129660] [] ? __wait_rcu_gp+0xc2/0xf0 [303020.136864] [] ? synchronize_sched+0x59/0x80 [303020.144733] [] ? call_rcu_bh+0x20/0x20 [303020.152382] [] ? trace_raw_output_rcu_utilization+0x60/0x60 [303020.161665] [] ? kern_unmount+0x27/0x50 [303020.168840] [] ? process_one_work+0x18a/0x430 [303020.175075] [] ? worker_thread+0x4d/0x490 [303020.182364] [] ? process_one_work+0x430/0x430 [303020.188609] [] ? kthread+0xd9/0xf0 [303020.195287] [] ? kthread_park+0x60/0x60 [303020.201136] [] ? ret_from_fork+0x57/0x70 [303020.208342] INFO: task kworker/51:0:23723 blocked for more than 120 seconds. [303020.216977] Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303020.226595] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [303020.236208] kworker/51:0 D 0 23723 2 0x00000080 [303020.243470] Workqueue: events proc_cleanup_work [303020.249803] 0000000000000046 ffff9fca712fa800 ffff9fca712fa800 ffff9fb07f454100 [303020.259908] ffff9fca872d8980 ffff9fc0b7d87040 ffffba1982b1fc90 ffffffffa1419609 [303020.271331] 0000000000000002 0000000000000000 ffff9fca872d8980 85ef7e4dcfd42f87 [303020.284547] Call Trace: [303020.288617] [] ? __schedule+0x239/0x6f0 [303020.295888] [] ? schedule+0x32/0x80 [303020.303145] [] ? schedule_timeout+0x1dd/0x380 [303020.311268] [] ? unmap_pmd_range+0x1fa/0x230 [303020.318927] [] ? __switch_to_asm+0x41/0x70 [303020.326462] [] ? __switch_to_asm+0x35/0x70 [303020.333780] [] ? wait_for_completion+0xf1/0x130 [303020.342218] [] ? wake_up_q+0x70/0x70 [303020.349304] [] ? __wait_rcu_gp+0xc2/0xf0 [303020.356569] [] ? synchronize_sched+0x59/0x80 [303020.364112] [] ? call_rcu_bh+0x20/0x20 [303020.371098] [] ? trace_raw_output_rcu_utilization+0x60/0x60 [303020.380006] [] ? kern_unmount+0x27/0x50 [303020.385721] [] ? process_one_work+0x18a/0x430 [303020.393593] [] ? worker_thread+0x4d/0x490 [303020.401076] [] ? process_one_work+0x430/0x430 [303020.408668] [] ? kthread+0xd9/0xf0 [303020.415550] [] ? __switch_to_asm+0x41/0x70 [303020.421543] [] ? kthread_park+0x60/0x60 [303020.428721] [] ? ret_from_fork+0x57/0x70 [303020.438395] INFO: task exe:60111 blocked for more than 120 seconds. [303020.445676] Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303020.455506] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [303020.465172] exe D 0 60111 59961 0x00000180 [303020.474037] 0000000000000086 ffff9fc0fb568c00 0000000000000000 ffff9fba8c611140 [303020.487749] ffff9fca875d8980 ffff9fca79634080 ffffba194f343c70 ffffffffa1419609 [303020.500208] ffffffffa0efff98 00ff9fba8c611140 ffff9fca875d8980 0000000000000000 [303020.513319] Call Trace: [303020.516012] [] ? __schedule+0x239/0x6f0 [303020.523123] [] ? smp_call_function_single+0xc8/0x130 [303020.531549] [] ? schedule+0x32/0x80 [303020.538471] [] ? schedule_timeout+0x1dd/0x380 [303020.546089] [] ? futex_wait+0x223/0x250 [303020.553268] [] ? wait_for_completion+0xf1/0x130 [303020.562084] [] ? wake_up_q+0x70/0x70 [303020.567545] [] ? __wait_rcu_gp+0xc2/0xf0 [303020.574718] [] ? synchronize_sched+0x59/0x80 [303020.582258] [] ? call_rcu_bh+0x20/0x20 [303020.589534] [] ? trace_raw_output_rcu_utilization+0x60/0x60 [303020.598620] [] ? kvm_vcpu_ioctl+0x5c0/0x5e0 [kvm] [303020.606555] [] ? signal_setup_done+0x67/0xb0 [303020.614343] [] ? __seccomp_filter+0x74/0x270 [303020.621950] [] ? do_vfs_ioctl+0xa2/0x620 [303020.629301] [] ? __audit_syscall_entry+0xaa/0xf0 [303020.637439] [] ? syscall_trace_enter+0x1ae/0x2c0 [303020.645462] [] ? SyS_ioctl+0x74/0x80 [303020.652477] [] ? do_syscall_64+0x8d/0x100 [303020.659716] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303020.668523] INFO: task exe:5392 blocked for more than 120 seconds. [303020.676177] Tainted: G L 4.9.0-11-amd64 #1 Debian 4.9.189-3+deb9u2 [303020.685830] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [303020.695352] exe D 0 5392 60762 0x00000180 [303020.703981] 0000000000000086 ffff9fbce2a40400 ffff9fbce2a40400 ffff9fc0fb52d000 [303020.715067] ffff9fca86c58980 ffff9fc4b5c8c080 ffffba196ebcfc70 ffffffffa1419609 [303020.728408] ffffffffa0efff98 00ffffffa141e4e5 ffff9fca86c58980 0000000000000000 [303020.739509] Call Trace: [303020.743569] [] ? __schedule+0x239/0x6f0 [303020.750651] [] ? smp_call_function_single+0xc8/0x130 [303020.759527] [] ? schedule+0x32/0x80 [303020.766360] [] ? schedule_timeout+0x1dd/0x380 [303020.772594] [] ? __switch_to+0x331/0x670 [303020.779767] [] ? wait_for_completion+0xf1/0x130 [303020.787570] [] ? wake_up_q+0x70/0x70 [303020.794390] [] ? __wait_rcu_gp+0xc2/0xf0 [303020.801812] [] ? synchronize_sched+0x59/0x80 [303020.809304] [] ? call_rcu_bh+0x20/0x20 [303020.815111] [] ? trace_raw_output_rcu_utilization+0x60/0x60 [303020.823994] [] ? kvm_vcpu_ioctl+0x5c0/0x5e0 [kvm] [303020.832035] [] ? signal_setup_done+0x67/0xb0 [303020.839548] [] ? __seccomp_filter+0x74/0x270 [303020.847770] [] ? do_vfs_ioctl+0xa2/0x620 [303020.857762] [] ? __audit_syscall_entry+0xaa/0xf0 [303020.865625] [] ? syscall_trace_enter+0x1ae/0x2c0 [303020.873493] [] ? SyS_ioctl+0x74/0x80 [303020.880318] [] ? do_syscall_64+0x8d/0x100 [303020.887600] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303021.093884] audit_log_start: 146 callbacks suppressed [303021.093885] audit: audit_backlog=321 > audit_backlog_limit=320 [303021.107912] audit: audit_lost=634 audit_rate_limit=0 audit_backlog_limit=320 [303021.115188] audit: backlog limit exceeded [303021.130422] audit: audit_backlog=321 > audit_backlog_limit=320 [303021.137568] audit: audit_lost=635 audit_rate_limit=0 audit_backlog_limit=320 [303021.146623] audit: backlog limit exceeded [303021.171361] audit: audit_backlog=321 > audit_backlog_limit=320 [303021.178678] audit: audit_lost=636 audit_rate_limit=0 audit_backlog_limit=320 [303021.187977] audit: backlog limit exceeded [303021.193520] audit: audit_backlog=321 > audit_backlog_limit=320 [303026.412238] audit_log_start: 116 callbacks suppressed [303026.412239] audit: audit_backlog=321 > audit_backlog_limit=320 [303026.424944] audit: audit_lost=676 audit_rate_limit=0 audit_backlog_limit=320 [303026.433612] audit: backlog limit exceeded [303026.445783] audit: audit_backlog=321 > audit_backlog_limit=320 [303026.452379] audit: audit_lost=677 audit_rate_limit=0 audit_backlog_limit=320 [303026.461394] audit: backlog limit exceeded [303026.484344] audit: audit_backlog=321 > audit_backlog_limit=320 [303026.491471] audit: audit_lost=678 audit_rate_limit=0 audit_backlog_limit=320 [303026.500259] audit: backlog limit exceeded [303026.519118] audit: audit_backlog=321 > audit_backlog_limit=320 [303031.444387] audit_log_start: 65 callbacks suppressed [303031.444389] audit: audit_backlog=321 > audit_backlog_limit=320 [303031.455868] audit: audit_lost=701 audit_rate_limit=0 audit_backlog_limit=320 [303031.463179] audit: backlog limit exceeded [303031.811529] audit: audit_backlog=321 > audit_backlog_limit=320 [303031.817751] audit: audit_lost=702 audit_rate_limit=0 audit_backlog_limit=320 [303031.825140] audit: backlog limit exceeded [303031.837907] audit: audit_backlog=321 > audit_backlog_limit=320 [303031.844046] audit: audit_lost=703 audit_rate_limit=0 audit_backlog_limit=320 [303031.852783] audit: backlog limit exceeded [303031.859636] audit: audit_backlog=321 > audit_backlog_limit=320 [303036.522213] audit_log_start: 35 callbacks suppressed [303036.527585] audit: audit_backlog=321 > audit_backlog_limit=320 [303036.533762] audit: audit_lost=716 audit_rate_limit=0 audit_backlog_limit=320 [303036.539392] audit: audit_backlog=321 > audit_backlog_limit=320 [303036.539394] audit: audit_lost=717 audit_rate_limit=0 audit_backlog_limit=320 [303036.539395] audit: backlog limit exceeded [303036.544137] audit: audit_backlog=321 > audit_backlog_limit=320 [303036.544139] audit: audit_lost=718 audit_rate_limit=0 audit_backlog_limit=320 [303036.544140] audit: backlog limit exceeded [303036.552809] audit: audit_backlog=321 > audit_backlog_limit=320 [303036.552810] audit: audit_lost=719 audit_rate_limit=0 audit_backlog_limit=320 [303040.008071] INFO: rcu_sched self-detected stall on CPU [303040.008072] INFO: rcu_sched self-detected stall on CPU [303040.008074] INFO: rcu_sched self-detected stall on CPU [303040.008078] 32-...: (36753 ticks this GP) idle=643/140000000000001/0 softirq=33655529/33655529 fqs=15218 [303040.008082] INFO: rcu_sched self-detected stall on CPU [303040.008083] INFO: rcu_sched self-detected stall on CPU [303040.008089] INFO: rcu_sched self-detected stall on CPU [303040.008089] 0-...: (36744 ticks this GP) idle=f87/140000000000001/0 softirq=33809629/33809629 fqs=15218 [303040.008091] [303040.008093] INFO: rcu_sched self-detected stall on CPU [303040.008095] [303040.008099] 8-...: (36755 ticks this GP) idle=e89/140000000000001/0 softirq=33412889/33412889 fqs=15218 [303040.008101] (t=36757 jiffies g=12067405 c=12067404 q=144495) [303040.008102] (t=36757 jiffies g=12067405 c=12067404 q=144495) [303040.008103] Task dump for CPU 0: [303040.008111] 33-...: (36755 ticks this GP) idle=4f5/140000000000001/0 softirq=33502188/33502188 fqs=15219 [303040.008115] 45-...: (36752 ticks this GP) idle=1e9/140000000000001/0 softirq=33633516/33633516 fqs=15219 [303040.008119] 42-...: (36752 ticks this GP) idle=333/140000000000001/0 softirq=33676374/33676374 fqs=15219 [303040.008121] [303040.008122] [303040.008124] [303040.008125] [303040.008128] exe R running task [303040.008128] (t=36757 jiffies g=12067405 c=12067404 q=144495) [303040.008130] (t=36757 jiffies g=12067405 c=12067404 q=144495) [303040.008132] 0 9806 60665 0x00000988 [303040.008134] (t=36757 jiffies g=12067405 c=12067404 q=144495) [303040.008137] ffffffffa1b19a00 [303040.008137] (t=36757 jiffies g=12067405 c=12067404 q=144495) [303040.008139] ffffffffa0ea953b 0000000000000000 ffffffffa1b19a00 [303040.008141] ffffffffa0f830ad ffff9fca866196c0 ffffffffa1a4fd80 0000000000000000 [303040.008143] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002bb80af [303040.008144] Call Trace: [303040.008151] [303040.008152] [] ? sched_show_task+0xcb/0x130 [303040.008155] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [303040.008158] [] ? rcu_check_callbacks+0x75a/0x8b0 [303040.008162] [] ? tick_sched_do_timer+0x30/0x30 [303040.008164] [] ? update_process_times+0x28/0x50 [303040.008166] [] ? tick_sched_handle.isra.12+0x20/0x50 [303040.008168] [] ? tick_sched_timer+0x38/0x70 [303040.008169] [] ? __hrtimer_run_queues+0xde/0x250 [303040.008171] [] ? hrtimer_interrupt+0x9c/0x1a0 [303040.008174] [] ? smp_apic_timer_interrupt+0x47/0x60 [303040.008177] [] ? apic_timer_interrupt+0x9e/0xb0 [303040.008180] [303040.008180] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.008182] [] ? _raw_spin_lock+0x1d/0x20 [303040.008209] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.008215] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008231] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.008235] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008238] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008241] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008244] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008246] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008249] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008252] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008255] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008258] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008261] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.008276] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008291] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303040.008293] [] ? recalc_sigpending+0x17/0x50 [303040.008305] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008307] [] ? signal_setup_done+0x67/0xb0 [303040.008309] [] ? __seccomp_filter+0x74/0x270 [303040.008311] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008313] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008315] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008317] [] ? SyS_ioctl+0x74/0x80 [303040.008319] [] ? do_syscall_64+0x8d/0x100 [303040.008321] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008322] Task dump for CPU 8: [303040.008324] exe R running task 0 4291 60665 0x00000188 [303040.008326] 00000000007ccfff 00003ffffffff000 00000000007cd000 ffffff8000000000 [303040.008328] 0000008000000000 00000000007ccfff ffff9fc0b95f6000 00000000007cd000 [303040.008330] 0000000000000287 00000001000fe000 ffffba196b5f7b40 0000000000000287 [303040.008330] Call Trace: [303040.008343] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [303040.008345] [] ? entry_SYSCALL_64_after_swapgs+0x8a/0xc6 [303040.008347] [] ? __switch_to_asm+0x35/0x70 [303040.008348] [] ? __switch_to_asm+0x41/0x70 [303040.008350] [] ? __switch_to_asm+0x35/0x70 [303040.008351] [] ? __switch_to_asm+0x35/0x70 [303040.008353] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.008354] [] ? _r