D0321 12:22:28.438511 5513 parameters.go:238] Clock(Monotonic): error: 229 ns, adjusted frequency from 2299774078 Hz to 2299774846 Hz D0321 12:22:28.439067 5513 parameters.go:238] Clock(Realtime): error: 161 ns, adjusted frequency from 2299774166 Hz to 2299774737 Hz D0321 12:22:28.439220 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712533002017441 monotonicBaseRef:2001200405 monotonicFrequency:2299774846 realtimeReady:1 realtimeBaseCycles:1712533003347488 realtimeBaseRef:1584793348439058368 realtimeFrequency:2299774737} D0321 12:22:29.437814 5513 parameters.go:238] Clock(Monotonic): error: 254 ns, adjusted frequency from 2299774846 Hz to 2299775090 Hz D0321 12:22:29.438075 5513 parameters.go:238] Clock(Realtime): error: 157 ns, adjusted frequency from 2299774737 Hz to 2299774842 Hz D0321 12:22:29.438197 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712535300119697 monotonicBaseRef:3000473120 monotonicFrequency:2299775090 realtimeReady:1 realtimeBaseCycles:1712535300846546 realtimeBaseRef:1584793349438068845 realtimeFrequency:2299774842} D0321 12:22:30.437591 5513 parameters.go:238] Clock(Monotonic): error: -142 ns, adjusted frequency from 2299775090 Hz to 2299774162 Hz D0321 12:22:30.437839 5513 parameters.go:238] Clock(Realtime): error: -33 ns, adjusted frequency from 2299774842 Hz to 2299774438 Hz D0321 12:22:30.437947 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712537599395691 monotonicBaseRef:4000256100 monotonicFrequency:2299774162 realtimeReady:1 realtimeBaseCycles:1712537600079766 realtimeBaseRef:1584793350437833334 realtimeFrequency:2299774438} D0321 12:22:31.437596 5513 parameters.go:238] Clock(Monotonic): error: 56 ns, adjusted frequency from 2299774162 Hz to 2299774641 Hz D0321 12:22:31.437820 5513 parameters.go:238] Clock(Realtime): error: 51 ns, adjusted frequency from 2299774438 Hz to 2299774656 Hz D0321 12:22:31.437942 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712539899269031 monotonicBaseRef:5000299225 monotonicFrequency:2299774641 realtimeReady:1 realtimeBaseCycles:1712539899813133 realtimeBaseRef:1584793351437815475 realtimeFrequency:2299774656} D0321 12:22:32.437559 5513 parameters.go:238] Clock(Monotonic): error: -30 ns, adjusted frequency from 2299774641 Hz to 2299774456 Hz D0321 12:22:32.437800 5513 parameters.go:238] Clock(Realtime): error: -81 ns, adjusted frequency from 2299774656 Hz to 2299774345 Hz D0321 12:22:32.437910 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712542198964856 monotonicBaseRef:6000264953 monotonicFrequency:2299774456 realtimeReady:1 realtimeBaseCycles:1712542199540421 realtimeBaseRef:1584793352437794878 realtimeFrequency:2299774345} D0321 12:22:33.437545 5513 parameters.go:238] Clock(Monotonic): error: 226 ns, adjusted frequency from 2299774456 Hz to 2299775080 Hz D0321 12:22:33.437819 5513 parameters.go:238] Clock(Realtime): error: 282 ns, adjusted frequency from 2299774345 Hz to 2299775230 Hz D0321 12:22:33.438017 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712544498694699 monotonicBaseRef:7000245554 monotonicFrequency:2299775080 realtimeReady:1 realtimeBaseCycles:1712544499356584 realtimeBaseRef:1584793353437813061 realtimeFrequency:2299775230} D0321 12:22:34.437609 5513 parameters.go:238] Clock(Monotonic): error: -39 ns, adjusted frequency from 2299775080 Hz to 2299774458 Hz D0321 12:22:34.437829 5513 parameters.go:238] Clock(Realtime): error: -114 ns, adjusted frequency from 2299775230 Hz to 2299774309 Hz D0321 12:22:34.437946 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712546798556586 monotonicBaseRef:8000283299 monotonicFrequency:2299774458 realtimeReady:1 realtimeBaseCycles:1712546799156818 realtimeBaseRef:1584793354437823933 realtimeFrequency:2299774309} D0321 12:22:35.437538 5513 parameters.go:238] Clock(Monotonic): error: 113 ns, adjusted frequency from 2299774458 Hz to 2299774831 Hz D0321 12:22:35.437770 5513 parameters.go:238] Clock(Realtime): error: -53 ns, adjusted frequency from 2299774309 Hz to 2299774446 Hz D0321 12:22:35.437877 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712549098227383 monotonicBaseRef:9000238224 monotonicFrequency:2299774831 realtimeReady:1 realtimeBaseCycles:1712549098795522 realtimeBaseRef:1584793355437764968 realtimeFrequency:2299774446} D0321 12:22:36.437679 5513 parameters.go:238] Clock(Monotonic): error: -69 ns, adjusted frequency from 2299774831 Hz to 2299774471 Hz D0321 12:22:36.437894 5513 parameters.go:238] Clock(Realtime): error: 139 ns, adjusted frequency from 2299774446 Hz to 2299774954 Hz D0321 12:22:36.438025 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712551398334132 monotonicBaseRef:10000382550 monotonicFrequency:2299774471 realtimeReady:1 realtimeBaseCycles:1712551398856102 realtimeBaseRef:1584793356437889386 realtimeFrequency:2299774954} D0321 12:22:37.437944 5513 parameters.go:238] Clock(Monotonic): error: 96 ns, adjusted frequency from 2299774471 Hz to 2299774866 Hz D0321 12:22:37.438281 5513 parameters.go:238] Clock(Realtime): error: 99 ns, adjusted frequency from 2299774954 Hz to 2299774875 Hz D0321 12:22:37.438398 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712553698701836 monotonicBaseRef:11000640502 monotonicFrequency:2299774866 realtimeReady:1 realtimeBaseCycles:1712553699517294 realtimeBaseRef:1584793357438274744 realtimeFrequency:2299774875} D0321 12:22:38.437544 5513 parameters.go:238] Clock(Monotonic): error: 20 ns, adjusted frequency from 2299774866 Hz to 2299774661 Hz D0321 12:22:38.437845 5513 parameters.go:238] Clock(Realtime): error: 63 ns, adjusted frequency from 2299774875 Hz to 2299774794 Hz D0321 12:22:38.438004 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712555997542377 monotonicBaseRef:12000234233 monotonicFrequency:2299774661 realtimeReady:1 realtimeBaseCycles:1712555998286736 realtimeBaseRef:1584793358437837556 realtimeFrequency:2299774794} D0321 12:22:39.437540 5513 parameters.go:238] Clock(Monotonic): error: -73 ns, adjusted frequency from 2299774661 Hz to 2299774460 Hz D0321 12:22:39.437744 5513 parameters.go:238] Clock(Realtime): error: -217 ns, adjusted frequency from 2299774794 Hz to 2299774132 Hz D0321 12:22:39.438317 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712558297335068 monotonicBaseRef:13000242072 monotonicFrequency:2299774460 realtimeReady:1 realtimeBaseCycles:1712558297836380 realtimeBaseRef:1584793359437739655 realtimeFrequency:2299774132} D0321 12:22:40.437562 5513 parameters.go:238] Clock(Monotonic): error: 96 ns, adjusted frequency from 2299774460 Hz to 2299774869 Hz D0321 12:22:40.437835 5513 parameters.go:238] Clock(Realtime): error: 173 ns, adjusted frequency from 2299774132 Hz to 2299775045 Hz D0321 12:22:40.437981 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712560597150702 monotonicBaseRef:14000259975 monotonicFrequency:2299774869 realtimeReady:1 realtimeBaseCycles:1712560597799491 realtimeBaseRef:1584793360437821827 realtimeFrequency:2299775045} D0321 12:22:41.437646 5513 parameters.go:238] Clock(Monotonic): error: -100 ns, adjusted frequency from 2299774869 Hz to 2299774410 Hz D0321 12:22:41.437869 5513 parameters.go:238] Clock(Realtime): error: -164 ns, adjusted frequency from 2299775045 Hz to 2299774266 Hz D0321 12:22:41.438012 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712562897132306 monotonicBaseRef:15000349868 monotonicFrequency:2299774410 realtimeReady:1 realtimeBaseCycles:1712562897671265 realtimeBaseRef:1584793361437863887 realtimeFrequency:2299774266} D0321 12:22:42.437618 5513 parameters.go:238] Clock(Monotonic): error: 21 ns, adjusted frequency from 2299774410 Hz to 2299774684 Hz D0321 12:22:42.437835 5513 parameters.go:238] Clock(Realtime): error: -10 ns, adjusted frequency from 2299774266 Hz to 2299774596 Hz D0321 12:22:42.438030 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712565196785919 monotonicBaseRef:16000297342 monotonicFrequency:2299774684 realtimeReady:1 realtimeBaseCycles:1712565197366729 realtimeBaseRef:1584793362437829621 realtimeFrequency:2299774596} D0321 12:22:43.437575 5513 parameters.go:238] Clock(Monotonic): error: 115 ns, adjusted frequency from 2299774684 Hz to 2299774929 Hz D0321 12:22:43.437835 5513 parameters.go:238] Clock(Realtime): error: 91 ns, adjusted frequency from 2299774596 Hz to 2299774851 Hz D0321 12:22:43.437973 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712567496512206 monotonicBaseRef:17000276297 monotonicFrequency:2299774929 realtimeReady:1 realtimeBaseCycles:1712567497137780 realtimeBaseRef:1584793363437828079 realtimeFrequency:2299774851} D0321 12:22:44.437893 5513 parameters.go:238] Clock(Monotonic): error: -150 ns, adjusted frequency from 2299774929 Hz to 2299774292 Hz D0321 12:22:44.438154 5513 parameters.go:238] Clock(Realtime): error: 130 ns, adjusted frequency from 2299774851 Hz to 2299774967 Hz D0321 12:22:44.438280 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712569797003687 monotonicBaseRef:18000587871 monotonicFrequency:2299774292 realtimeReady:1 realtimeBaseCycles:1712569797643594 realtimeBaseRef:1584793364438145920 realtimeFrequency:2299774967} D0321 12:22:45.438022 5513 parameters.go:238] Clock(Monotonic): error: 32 ns, adjusted frequency from 2299774292 Hz to 2299774721 Hz D0321 12:22:45.438260 5513 parameters.go:238] Clock(Realtime): error: -200 ns, adjusted frequency from 2299774967 Hz to 2299774176 Hz D0321 12:22:45.438409 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712572097089806 monotonicBaseRef:19000723461 monotonicFrequency:2299774721 realtimeReady:1 realtimeBaseCycles:1712572097668970 realtimeBaseRef:1584793365438254804 realtimeFrequency:2299774176} D0321 12:22:46.437494 5513 parameters.go:238] Clock(Monotonic): error: -27 ns, adjusted frequency from 2299774721 Hz to 2299774573 Hz D0321 12:22:46.437732 5513 parameters.go:238] Clock(Realtime): error: -9 ns, adjusted frequency from 2299774176 Hz to 2299774601 Hz D0321 12:22:46.437848 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712574395647047 monotonicBaseRef:20000194070 monotonicFrequency:2299774573 realtimeReady:1 realtimeBaseCycles:1712574396226811 realtimeBaseRef:1584793366437725910 realtimeFrequency:2299774601} D0321 12:22:47.437552 5513 parameters.go:238] Clock(Monotonic): error: 130 ns, adjusted frequency from 2299774573 Hz to 2299774950 Hz D0321 12:22:47.437792 5513 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0321 12:22:47.437934 5513 parameters.go:238] Clock(Realtime): error: 308 ns, adjusted frequency from 2299774601 Hz to 2299775323 Hz D0321 12:22:47.438110 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712576695560077 monotonicBaseRef:21000254274 monotonicFrequency:2299774950 realtimeReady:1 realtimeBaseCycles:1712576696464355 realtimeBaseRef:1584793367437927209 realtimeFrequency:2299775323} D0321 12:22:48.437559 5513 parameters.go:238] Clock(Monotonic): error: -184 ns, adjusted frequency from 2299774950 Hz to 2299774204 Hz D0321 12:22:48.437807 5513 parameters.go:238] Clock(Realtime): error: 167 ns, adjusted frequency from 2299775323 Hz to 2299774988 Hz D0321 12:22:48.437979 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712578995307955 monotonicBaseRef:22000242502 monotonicFrequency:2299774204 realtimeReady:1 realtimeBaseCycles:1712578995945990 realtimeBaseRef:1584793368437799506 realtimeFrequency:2299774988} D0321 12:22:49.437689 5513 parameters.go:238] Clock(Monotonic): error: -82 ns, adjusted frequency from 2299774204 Hz to 2299774428 Hz D0321 12:22:49.437899 5513 parameters.go:238] Clock(Realtime): error: -354 ns, adjusted frequency from 2299774988 Hz to 2299773774 Hz D0321 12:22:49.438037 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712581295433263 monotonicBaseRef:23000395170 monotonicFrequency:2299774428 realtimeReady:1 realtimeBaseCycles:1712581295938942 realtimeBaseRef:1584793369437894282 realtimeFrequency:2299773774} D0321 12:22:50.437938 5513 parameters.go:238] Clock(Monotonic): error: 52 ns, adjusted frequency from 2299774428 Hz to 2299774758 Hz D0321 12:22:50.438109 5513 parameters.go:238] Clock(Realtime): error: 63 ns, adjusted frequency from 2299773774 Hz to 2299774747 Hz D0321 12:22:50.438249 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712583595770288 monotonicBaseRef:24000639801 monotonicFrequency:2299774758 realtimeReady:1 realtimeBaseCycles:1712583596195567 realtimeBaseRef:1584793370438104237 realtimeFrequency:2299774747} D0321 12:22:51.437578 5513 parameters.go:238] Clock(Monotonic): error: 90 ns, adjusted frequency from 2299774758 Hz to 2299774837 Hz D0321 12:22:51.437835 5513 parameters.go:238] Clock(Realtime): error: 169 ns, adjusted frequency from 2299774747 Hz to 2299775000 Hz D0321 12:22:51.437944 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712585894717382 monotonicBaseRef:25000279911 monotonicFrequency:2299774837 realtimeReady:1 realtimeBaseCycles:1712585895337109 realtimeBaseRef:1584793371437828903 realtimeFrequency:2299775000} D0321 12:22:52.437604 5513 parameters.go:238] Clock(Monotonic): error: 99 ns, adjusted frequency from 2299774837 Hz to 2299774855 Hz D0321 12:22:52.437870 5513 parameters.go:238] Clock(Realtime): error: -39 ns, adjusted frequency from 2299775000 Hz to 2299774458 Hz D0321 12:22:52.438036 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712588194520517 monotonicBaseRef:26000292215 monotonicFrequency:2299774855 realtimeReady:1 realtimeBaseCycles:1712588195188396 realtimeBaseRef:1584793372437862074 realtimeFrequency:2299774458} D0321 12:22:53.437605 5513 parameters.go:238] Clock(Monotonic): error: -58 ns, adjusted frequency from 2299774855 Hz to 2299774508 Hz D0321 12:22:53.437861 5513 parameters.go:238] Clock(Realtime): error: 177 ns, adjusted frequency from 2299774458 Hz to 2299775004 Hz D0321 12:22:53.437967 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712590494318594 monotonicBaseRef:27000302312 monotonicFrequency:2299774508 realtimeReady:1 realtimeBaseCycles:1712590494948077 realtimeBaseRef:1584793373437855648 realtimeFrequency:2299775004} D0321 12:22:54.437601 5513 parameters.go:238] Clock(Monotonic): error: 14 ns, adjusted frequency from 2299774508 Hz to 2299774657 Hz D0321 12:22:54.437841 5513 parameters.go:238] Clock(Realtime): error: -212 ns, adjusted frequency from 2299775004 Hz to 2299774043 Hz D0321 12:22:54.438035 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712592794089964 monotonicBaseRef:28000300947 monotonicFrequency:2299774657 realtimeReady:1 realtimeBaseCycles:1712592794675036 realtimeBaseRef:1584793374437834756 realtimeFrequency:2299774043} D0321 12:22:55.437559 5513 parameters.go:238] Clock(Monotonic): error: 70 ns, adjusted frequency from 2299774657 Hz to 2299774804 Hz D0321 12:22:55.437811 5513 parameters.go:238] Clock(Realtime): error: 54 ns, adjusted frequency from 2299774043 Hz to 2299774766 Hz D0321 12:22:55.438043 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712595093772161 monotonicBaseRef:29000260743 monotonicFrequency:2299774804 realtimeReady:1 realtimeBaseCycles:1712595094363672 realtimeBaseRef:1584793375437797618 realtimeFrequency:2299774766} D0321 12:22:56.437510 5513 parameters.go:238] Clock(Monotonic): error: -99 ns, adjusted frequency from 2299774804 Hz to 2299774400 Hz D0321 12:22:56.437705 5513 parameters.go:238] Clock(Realtime): error: 13 ns, adjusted frequency from 2299774766 Hz to 2299774638 Hz D0321 12:22:56.437829 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712597393436400 monotonicBaseRef:30000212666 monotonicFrequency:2299774400 realtimeReady:1 realtimeBaseCycles:1712597393914938 realtimeBaseRef:1584793376437700434 realtimeFrequency:2299774638} D0321 12:22:57.437504 5513 parameters.go:238] Clock(Monotonic): error: 9 ns, adjusted frequency from 2299774400 Hz to 2299774675 Hz D0321 12:22:57.437758 5513 parameters.go:238] Clock(Realtime): error: 205 ns, adjusted frequency from 2299774638 Hz to 2299775076 Hz D0321 12:22:57.437928 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712599693182830 monotonicBaseRef:31000200503 monotonicFrequency:2299774675 realtimeReady:1 realtimeBaseCycles:1712599693808617 realtimeBaseRef:1584793377437752196 realtimeFrequency:2299775076} D0321 12:22:58.437669 5513 parameters.go:238] Clock(Monotonic): error: -37 ns, adjusted frequency from 2299774675 Hz to 2299774565 Hz D0321 12:22:58.437876 5513 parameters.go:238] Clock(Realtime): error: -126 ns, adjusted frequency from 2299775076 Hz to 2299774351 Hz D0321 12:22:58.438012 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712601993350396 monotonicBaseRef:32000371341 monotonicFrequency:2299774565 realtimeReady:1 realtimeBaseCycles:1712601993855093 realtimeBaseRef:1584793378437870207 realtimeFrequency:2299774351} D0321 12:22:59.437582 5513 parameters.go:238] Clock(Monotonic): error: 31 ns, adjusted frequency from 2299774565 Hz to 2299774713 Hz D0321 12:22:59.437906 5513 parameters.go:238] Clock(Realtime): error: 569 ns, adjusted frequency from 2299774351 Hz to 2299775961 Hz D0321 12:22:59.438142 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712604292922364 monotonicBaseRef:33000283246 monotonicFrequency:2299774713 realtimeReady:1 realtimeBaseCycles:1712604293694971 realtimeBaseRef:1584793379437898699 realtimeFrequency:2299775961} D0321 12:23:00.438136 5513 parameters.go:238] Clock(Monotonic): error: 100 ns, adjusted frequency from 2299774713 Hz to 2299774878 Hz D0321 12:23:00.438501 5513 parameters.go:238] Clock(Realtime): error: -292 ns, adjusted frequency from 2299775961 Hz to 2299773981 Hz D0321 12:23:00.438683 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712606593964608 monotonicBaseRef:34000834400 monotonicFrequency:2299774878 realtimeReady:1 realtimeBaseCycles:1712606594836977 realtimeBaseRef:1584793380438492689 realtimeFrequency:2299773981} D0321 12:23:01.437560 5513 parameters.go:238] Clock(Monotonic): error: -32 ns, adjusted frequency from 2299774878 Hz to 2299774565 Hz D0321 12:23:01.437816 5513 parameters.go:238] Clock(Realtime): error: -142 ns, adjusted frequency from 2299773981 Hz to 2299774344 Hz D0321 12:23:01.437931 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712608892424267 monotonicBaseRef:35000262509 monotonicFrequency:2299774565 realtimeReady:1 realtimeBaseCycles:1712608893037608 realtimeBaseRef:1584793381437808556 realtimeFrequency:2299774344} D0321 12:23:01.725343 5513 urpc.go:577] urpc: unmarshal success. D0321 12:23:01.725582 5513 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0321 12:23:01.726567 5513 urpc.go:534] urpc: successfully marshalled 37 bytes. D0321 12:23:02.437529 5513 sampler.go:168] Time: Adjusting syscall overhead up to 8000 D0321 12:23:02.438531 5513 parameters.go:238] Clock(Monotonic): error: 236 ns, adjusted frequency from 2299774565 Hz to 2299775165 Hz D0321 12:23:02.438864 5513 parameters.go:238] Clock(Realtime): error: 172 ns, adjusted frequency from 2299774344 Hz to 2299775001 Hz D0321 12:23:02.439021 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712611192626367 monotonicBaseRef:36000448412 monotonicFrequency:2299775165 realtimeReady:1 realtimeBaseCycles:1712611195217912 realtimeBaseRef:1584793382438854728 realtimeFrequency:2299775001} D0321 12:23:03.437931 5513 parameters.go:238] Clock(Monotonic): error: -253 ns, adjusted frequency from 2299775165 Hz to 2299773969 Hz D0321 12:23:03.438249 5513 parameters.go:238] Clock(Realtime): error: -374 ns, adjusted frequency from 2299775001 Hz to 2299773817 Hz D0321 12:23:03.438419 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712613492789000 monotonicBaseRef:37000616892 monotonicFrequency:2299773969 realtimeReady:1 realtimeBaseCycles:1712613493584773 realtimeBaseRef:1584793383438242433 realtimeFrequency:2299773817} D0321 12:23:04.437594 5513 parameters.go:238] Clock(Monotonic): error: 771 ns, adjusted frequency from 2299773969 Hz to 2299776388 Hz D0321 12:23:04.437856 5513 parameters.go:238] Clock(Realtime): error: -110 ns, adjusted frequency from 2299773817 Hz to 2299774350 Hz D0321 12:23:04.440375 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712615791818555 monotonicBaseRef:38000293201 monotonicFrequency:2299776388 realtimeReady:1 realtimeBaseCycles:1712615792452798 realtimeBaseRef:1584793384437848571 realtimeFrequency:2299774350} D0321 12:23:05.437749 5513 parameters.go:238] Clock(Monotonic): error: -385 ns, adjusted frequency from 2299776388 Hz to 2299773658 Hz D0321 12:23:05.438061 5513 parameters.go:238] Clock(Realtime): error: 325 ns, adjusted frequency from 2299774350 Hz to 2299775369 Hz D0321 12:23:05.438182 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712618091952048 monotonicBaseRef:39000448479 monotonicFrequency:2299773658 realtimeReady:1 realtimeBaseCycles:1712618092694905 realtimeBaseRef:1584793385438051963 realtimeFrequency:2299775369} D0321 12:23:06.437481 5513 parameters.go:238] Clock(Monotonic): error: 308 ns, adjusted frequency from 2299773658 Hz to 2299775304 Hz D0321 12:23:06.437737 5513 parameters.go:238] Clock(Realtime): error: 32 ns, adjusted frequency from 2299775369 Hz to 2299774704 Hz D0321 12:23:06.437904 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712620391109537 monotonicBaseRef:40000180553 monotonicFrequency:2299775304 realtimeReady:1 realtimeBaseCycles:1712620391729147 realtimeBaseRef:1584793386437729702 realtimeFrequency:2299774704} D0321 12:23:07.437553 5513 parameters.go:238] Clock(Monotonic): error: -404 ns, adjusted frequency from 2299775304 Hz to 2299773728 Hz D0321 12:23:07.437816 5513 parameters.go:238] Clock(Realtime): error: 57 ns, adjusted frequency from 2299774704 Hz to 2299774734 Hz D0321 12:23:07.437945 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712622691055103 monotonicBaseRef:41000254587 monotonicFrequency:2299773728 realtimeReady:1 realtimeBaseCycles:1712622691684644 realtimeBaseRef:1584793387437808315 realtimeFrequency:2299774734} D0321 12:23:08.437606 5513 parameters.go:238] Clock(Monotonic): error: -103 ns, adjusted frequency from 2299773728 Hz to 2299774423 Hz D0321 12:23:08.437857 5513 parameters.go:238] Clock(Realtime): error: -142 ns, adjusted frequency from 2299774734 Hz to 2299774297 Hz D0321 12:23:08.437972 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712624990946708 monotonicBaseRef:42000305842 monotonicFrequency:2299774423 realtimeReady:1 realtimeBaseCycles:1712624991557519 realtimeBaseRef:1584793388437850989 realtimeFrequency:2299774297} D0321 12:23:09.437553 5513 parameters.go:238] Clock(Monotonic): error: -40 ns, adjusted frequency from 2299774423 Hz to 2299774458 Hz D0321 12:23:09.437757 5513 parameters.go:238] Clock(Realtime): error: 210 ns, adjusted frequency from 2299774297 Hz to 2299775123 Hz D0321 12:23:09.437865 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712627290612082 monotonicBaseRef:43000258424 monotonicFrequency:2299774458 realtimeReady:1 realtimeBaseCycles:1712627291100069 realtimeBaseRef:1584793389437750219 realtimeFrequency:2299775123} D0321 12:23:10.437586 5513 parameters.go:238] Clock(Monotonic): error: 496 ns, adjusted frequency from 2299774458 Hz to 2299775695 Hz D0321 12:23:10.437794 5513 parameters.go:238] Clock(Realtime): error: -349 ns, adjusted frequency from 2299775123 Hz to 2299773850 Hz D0321 12:23:10.437934 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712629590451114 monotonicBaseRef:44000286502 monotonicFrequency:2299775695 realtimeReady:1 realtimeBaseCycles:1712629590963490 realtimeBaseRef:1584793390437788613 realtimeFrequency:2299773850} D0321 12:23:11.437558 5513 parameters.go:238] Clock(Monotonic): error: -163 ns, adjusted frequency from 2299775695 Hz to 2299774173 Hz D0321 12:23:11.437792 5513 parameters.go:238] Clock(Realtime): error: 53 ns, adjusted frequency from 2299773850 Hz to 2299774770 Hz D0321 12:23:11.437910 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712631890150568 monotonicBaseRef:45000253350 monotonicFrequency:2299774173 realtimeReady:1 realtimeBaseCycles:1712631890732818 realtimeBaseRef:1584793391437786646 realtimeFrequency:2299774770} I0321 12:23:11.795888 5513 watchdog.go:277] Watchdog starting loop, tasks: 14, discount: 0s D0321 12:23:12.437742 5513 parameters.go:238] Clock(Monotonic): error: 45 ns, adjusted frequency from 2299774173 Hz to 2299774784 Hz D0321 12:23:12.437931 5513 parameters.go:238] Clock(Realtime): error: -33 ns, adjusted frequency from 2299774770 Hz to 2299774588 Hz D0321 12:23:12.438061 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712634190307992 monotonicBaseRef:46000419997 monotonicFrequency:2299774784 realtimeReady:1 realtimeBaseCycles:1712634190825538 realtimeBaseRef:1584793392437924898 realtimeFrequency:2299774588} D0321 12:23:13.437569 5513 parameters.go:238] Clock(Monotonic): error: -196 ns, adjusted frequency from 2299774784 Hz to 2299774089 Hz D0321 12:23:13.437799 5513 parameters.go:238] Clock(Realtime): error: 3 ns, adjusted frequency from 2299774588 Hz to 2299774582 Hz D0321 12:23:13.437919 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712636489735394 monotonicBaseRef:47000268946 monotonicFrequency:2299774089 realtimeReady:1 realtimeBaseCycles:1712636490300517 realtimeBaseRef:1584793393437794620 realtimeFrequency:2299774582} D0321 12:23:14.437563 5513 parameters.go:238] Clock(Monotonic): error: 295 ns, adjusted frequency from 2299774089 Hz to 2299775287 Hz D0321 12:23:14.437787 5513 parameters.go:238] Clock(Realtime): error: 38 ns, adjusted frequency from 2299774582 Hz to 2299774733 Hz D0321 12:23:14.437891 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712638789460999 monotonicBaseRef:48000247863 monotonicFrequency:2299775287 realtimeReady:1 realtimeBaseCycles:1712638790046770 realtimeBaseRef:1584793394437782301 realtimeFrequency:2299774733} D0321 12:23:15.437572 5513 parameters.go:238] Clock(Monotonic): error: -185 ns, adjusted frequency from 2299775287 Hz to 2299774199 Hz D0321 12:23:15.437851 5513 parameters.go:238] Clock(Realtime): error: -313 ns, adjusted frequency from 2299774733 Hz to 2299773947 Hz D0321 12:23:15.438028 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712641089304628 monotonicBaseRef:49000277579 monotonicFrequency:2299774199 realtimeReady:1 realtimeBaseCycles:1712641089963076 realtimeBaseRef:1584793395437843860 realtimeFrequency:2299773947} D0321 12:23:16.437647 5513 parameters.go:238] Clock(Monotonic): error: 133 ns, adjusted frequency from 2299774199 Hz to 2299774871 Hz D0321 12:23:16.437890 5513 parameters.go:238] Clock(Realtime): error: 813 ns, adjusted frequency from 2299773947 Hz to 2299776551 Hz D0321 12:23:16.438010 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712643389228468 monotonicBaseRef:50000342646 monotonicFrequency:2299774871 realtimeReady:1 realtimeBaseCycles:1712643389830347 realtimeBaseRef:1584793396437884439 realtimeFrequency:2299776551} D0321 12:23:17.437538 5513 parameters.go:238] Clock(Monotonic): error: 63 ns, adjusted frequency from 2299774871 Hz to 2299774718 Hz D0321 12:23:17.437735 5513 parameters.go:238] Clock(Realtime): error: -532 ns, adjusted frequency from 2299776551 Hz to 2299773420 Hz D0321 12:23:17.437849 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712645688738018 monotonicBaseRef:51000227277 monotonicFrequency:2299774718 realtimeReady:1 realtimeBaseCycles:1712645689250056 realtimeBaseRef:1584793397437729275 realtimeFrequency:2299773420} D0321 12:23:17.779566 5513 urpc.go:577] urpc: unmarshal success. D0321 12:23:17.779852 5513 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0321 12:23:17.780126 5513 urpc.go:534] urpc: successfully marshalled 37 bytes. D0321 12:23:18.437548 5513 parameters.go:238] Clock(Monotonic): error: 114 ns, adjusted frequency from 2299774718 Hz to 2299774956 Hz D0321 12:23:18.437831 5513 parameters.go:238] Clock(Realtime): error: 189 ns, adjusted frequency from 2299773420 Hz to 2299775047 Hz D0321 12:23:18.437951 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712647988548128 monotonicBaseRef:52000242666 monotonicFrequency:2299774956 realtimeReady:1 realtimeBaseCycles:1712647989240864 realtimeBaseRef:1584793398437823800 realtimeFrequency:2299775047} D0321 12:23:19.438036 5513 parameters.go:238] Clock(Monotonic): error: -539 ns, adjusted frequency from 2299774956 Hz to 2299773479 Hz D0321 12:23:19.439520 5513 parameters.go:238] Clock(Realtime): error: -60 ns, adjusted frequency from 2299775047 Hz to 2299774494 Hz D0321 12:23:19.439653 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712650289453527 monotonicBaseRef:53000734211 monotonicFrequency:2299773479 realtimeReady:1 realtimeBaseCycles:1712650292903037 realtimeBaseRef:1584793399439514020 realtimeFrequency:2299774494} D0321 12:23:20.437556 5513 parameters.go:238] Clock(Monotonic): error: 322 ns, adjusted frequency from 2299773479 Hz to 2299775381 Hz D0321 12:23:20.437822 5513 parameters.go:238] Clock(Realtime): error: 97 ns, adjusted frequency from 2299774494 Hz to 2299774879 Hz D0321 12:23:20.438030 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712652588116242 monotonicBaseRef:54000251222 monotonicFrequency:2299775381 realtimeReady:1 realtimeBaseCycles:1712652588771885 realtimeBaseRef:1584793400437815746 realtimeFrequency:2299774879} D0321 12:23:21.437589 5513 parameters.go:238] Clock(Monotonic): error: 158 ns, adjusted frequency from 2299775381 Hz to 2299774996 Hz D0321 12:23:21.437859 5513 parameters.go:238] Clock(Realtime): error: -277 ns, adjusted frequency from 2299774879 Hz to 2299774050 Hz D0321 12:23:21.438017 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712654887969648 monotonicBaseRef:55000285149 monotonicFrequency:2299774996 realtimeReady:1 realtimeBaseCycles:1712654888627684 realtimeBaseRef:1584793401437850932 realtimeFrequency:2299774050} D0321 12:23:22.437565 5513 parameters.go:238] Clock(Monotonic): error: -161 ns, adjusted frequency from 2299774996 Hz to 2299774304 Hz D0321 12:23:22.437773 5513 parameters.go:238] Clock(Realtime): error: -80 ns, adjusted frequency from 2299774050 Hz to 2299774518 Hz D0321 12:23:22.437895 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712657187668929 monotonicBaseRef:56000252226 monotonicFrequency:2299774304 realtimeReady:1 realtimeBaseCycles:1712657188212566 realtimeBaseRef:1584793402437768676 realtimeFrequency:2299774518} D0321 12:23:23.438028 5513 parameters.go:238] Clock(Monotonic): error: 40 ns, adjusted frequency from 2299774304 Hz to 2299774745 Hz D0321 12:23:23.438302 5513 parameters.go:238] Clock(Realtime): error: 283 ns, adjusted frequency from 2299774518 Hz to 2299775254 Hz D0321 12:23:23.438449 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712659488536140 monotonicBaseRef:57000727449 monotonicFrequency:2299774745 realtimeReady:1 realtimeBaseCycles:1712659489194397 realtimeBaseRef:1584793403438293646 realtimeFrequency:2299775254} D0321 12:23:24.437660 5513 parameters.go:238] Clock(Monotonic): error: 148 ns, adjusted frequency from 2299774745 Hz to 2299774947 Hz D0321 12:23:24.437891 5513 parameters.go:238] Clock(Realtime): error: 81 ns, adjusted frequency from 2299775254 Hz to 2299774856 Hz D0321 12:23:24.438032 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712661787467476 monotonicBaseRef:58000360713 monotonicFrequency:2299774947 realtimeReady:1 realtimeBaseCycles:1712661788030019 realtimeBaseRef:1584793404437885070 realtimeFrequency:2299774856} D0321 12:23:25.438197 5513 parameters.go:238] Clock(Monotonic): error: -156 ns, adjusted frequency from 2299774947 Hz to 2299774261 Hz D0321 12:23:25.438459 5513 parameters.go:238] Clock(Realtime): error: -198 ns, adjusted frequency from 2299774856 Hz to 2299774186 Hz D0321 12:23:25.438585 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712664088477127 monotonicBaseRef:59000897593 monotonicFrequency:2299774261 realtimeReady:1 realtimeBaseCycles:1712664089111824 realtimeBaseRef:1584793405438453364 realtimeFrequency:2299774186} D0321 12:23:26.438882 5513 parameters.go:238] Clock(Monotonic): error: -130 ns, adjusted frequency from 2299774261 Hz to 2299774261 Hz D0321 12:23:26.439113 5513 parameters.go:238] Clock(Realtime): error: 123 ns, adjusted frequency from 2299774186 Hz to 2299774932 Hz D0321 12:23:26.439235 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712666389823041 monotonicBaseRef:60001580987 monotonicFrequency:2299774261 realtimeReady:1 realtimeBaseCycles:1712666390387095 realtimeBaseRef:1584793406439106073 realtimeFrequency:2299774932} D0321 12:23:27.437581 5513 parameters.go:238] Clock(Monotonic): error: -107 ns, adjusted frequency from 2299774261 Hz to 2299774296 Hz D0321 12:23:27.437808 5513 parameters.go:238] Clock(Realtime): error: -165 ns, adjusted frequency from 2299774932 Hz to 2299774199 Hz D0321 12:23:27.437907 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712668686615333 monotonicBaseRef:61000284351 monotonicFrequency:2299774296 realtimeReady:1 realtimeBaseCycles:1712668687163583 realtimeBaseRef:1584793407437802274 realtimeFrequency:2299774199} D0321 12:23:28.437537 5513 parameters.go:238] Clock(Monotonic): error: -87 ns, adjusted frequency from 2299774296 Hz to 2299774414 Hz D0321 12:23:28.437791 5513 parameters.go:238] Clock(Realtime): error: 168 ns, adjusted frequency from 2299774199 Hz to 2299775017 Hz D0321 12:23:28.437924 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712670986284037 monotonicBaseRef:62000238436 monotonicFrequency:2299774414 realtimeReady:1 realtimeBaseCycles:1712670986892610 realtimeBaseRef:1584793408437782632 realtimeFrequency:2299775017} D0321 12:23:29.437605 5513 parameters.go:238] Clock(Monotonic): error: 234 ns, adjusted frequency from 2299774414 Hz to 2299775090 Hz D0321 12:23:29.437851 5513 parameters.go:238] Clock(Realtime): error: -43 ns, adjusted frequency from 2299775017 Hz to 2299774503 Hz D0321 12:23:29.437960 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712673286190468 monotonicBaseRef:63000295840 monotonicFrequency:2299775090 realtimeReady:1 realtimeBaseCycles:1712673286810442 realtimeBaseRef:1584793409437844731 realtimeFrequency:2299774503} D0321 12:23:30.437550 5513 parameters.go:238] Clock(Monotonic): error: 34 ns, adjusted frequency from 2299775090 Hz to 2299774716 Hz D0321 12:23:30.437834 5513 parameters.go:238] Clock(Realtime): error: 72 ns, adjusted frequency from 2299774503 Hz to 2299774777 Hz D0321 12:23:30.437993 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712675585839564 monotonicBaseRef:64000241054 monotonicFrequency:2299774716 realtimeReady:1 realtimeBaseCycles:1712675586546347 realtimeBaseRef:1584793410437827947 realtimeFrequency:2299774777} D0321 12:23:31.437544 5513 parameters.go:238] Clock(Monotonic): error: 288 ns, adjusted frequency from 2299774716 Hz to 2299775300 Hz D0321 12:23:31.437820 5513 parameters.go:238] Clock(Realtime): error: 79 ns, adjusted frequency from 2299774777 Hz to 2299774815 Hz D0321 12:23:31.438023 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712677885605123 monotonicBaseRef:65000237072 monotonicFrequency:2299775300 realtimeReady:1 realtimeBaseCycles:1712677886285764 realtimeBaseRef:1584793411437812571 realtimeFrequency:2299774815} D0321 12:23:32.437536 5513 parameters.go:238] Clock(Monotonic): error: 89 ns, adjusted frequency from 2299775300 Hz to 2299774863 Hz D0321 12:23:32.437768 5513 parameters.go:238] Clock(Realtime): error: -3 ns, adjusted frequency from 2299774815 Hz to 2299774668 Hz D0321 12:23:32.437896 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712680185331767 monotonicBaseRef:66000215915 monotonicFrequency:2299774863 realtimeReady:1 realtimeBaseCycles:1712680185937532 realtimeBaseRef:1584793412437759067 realtimeFrequency:2299774668} D0321 12:23:33.437552 5513 parameters.go:238] Clock(Monotonic): error: -335 ns, adjusted frequency from 2299774863 Hz to 2299773821 Hz D0321 12:23:33.437820 5513 parameters.go:238] Clock(Realtime): error: -136 ns, adjusted frequency from 2299774668 Hz to 2299774310 Hz D0321 12:23:33.437969 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712682485190736 monotonicBaseRef:67000252486 monotonicFrequency:2299773821 realtimeReady:1 realtimeBaseCycles:1712682485839210 realtimeBaseRef:1584793413437814294 realtimeFrequency:2299774310} D0321 12:23:34.437520 5513 parameters.go:238] Clock(Monotonic): error: -109 ns, adjusted frequency from 2299773821 Hz to 2299774451 Hz D0321 12:23:34.437818 5513 parameters.go:238] Clock(Realtime): error: -180 ns, adjusted frequency from 2299774310 Hz to 2299774207 Hz D0321 12:23:34.437967 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712684784892561 monotonicBaseRef:68000221180 monotonicFrequency:2299774451 realtimeReady:1 realtimeBaseCycles:1712684785604198 realtimeBaseRef:1584793414437810240 realtimeFrequency:2299774207} D0321 12:23:35.437580 5513 parameters.go:238] Clock(Monotonic): error: 305 ns, adjusted frequency from 2299774451 Hz to 2299775377 Hz D0321 12:23:35.437854 5513 parameters.go:238] Clock(Realtime): error: 218 ns, adjusted frequency from 2299774207 Hz to 2299775123 Hz D0321 12:23:35.439251 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712687084802911 monotonicBaseRef:69000280272 monotonicFrequency:2299775377 realtimeReady:1 realtimeBaseCycles:1712687085464275 realtimeBaseRef:1584793415437847578 realtimeFrequency:2299775123} D0321 12:23:36.437532 5513 parameters.go:238] Clock(Monotonic): error: -334 ns, adjusted frequency from 2299775377 Hz to 2299773995 Hz D0321 12:23:36.437735 5513 parameters.go:238] Clock(Realtime): error: -287 ns, adjusted frequency from 2299775123 Hz to 2299774013 Hz D0321 12:23:36.437901 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712689384472012 monotonicBaseRef:70000234060 monotonicFrequency:2299773995 realtimeReady:1 realtimeBaseCycles:1712689384969635 realtimeBaseRef:1584793416437730278 realtimeFrequency:2299774013} D0321 12:23:37.437561 5513 parameters.go:238] Clock(Monotonic): error: -137 ns, adjusted frequency from 2299773995 Hz to 2299774344 Hz D0321 12:23:37.437833 5513 parameters.go:238] Clock(Realtime): error: 261 ns, adjusted frequency from 2299774013 Hz to 2299775227 Hz D0321 12:23:37.437991 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712691684306914 monotonicBaseRef:71000260543 monotonicFrequency:2299774344 realtimeReady:1 realtimeBaseCycles:1712691684962954 realtimeBaseRef:1584793417437825637 realtimeFrequency:2299775227} D0321 12:23:38.437623 5513 parameters.go:238] Clock(Monotonic): error: -87 ns, adjusted frequency from 2299774344 Hz to 2299774619 Hz D0321 12:23:38.437988 5513 parameters.go:238] Clock(Realtime): error: 52 ns, adjusted frequency from 2299775227 Hz to 2299774776 Hz D0321 12:23:38.438180 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712693984143565 monotonicBaseRef:72000287635 monotonicFrequency:2299774619 realtimeReady:1 realtimeBaseCycles:1712693985076145 realtimeBaseRef:1584793418437972592 realtimeFrequency:2299774776} D0321 12:23:39.437568 5513 parameters.go:238] Clock(Monotonic): error: -40 ns, adjusted frequency from 2299774619 Hz to 2299774591 Hz D0321 12:23:39.437805 5513 parameters.go:238] Clock(Realtime): error: -295 ns, adjusted frequency from 2299774776 Hz to 2299773911 Hz D0321 12:23:39.437949 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712696283878500 monotonicBaseRef:73000270379 monotonicFrequency:2299774591 realtimeReady:1 realtimeBaseCycles:1712696284453455 realtimeBaseRef:1584793419437799763 realtimeFrequency:2299773911} D0321 12:23:40.437637 5513 parameters.go:238] Clock(Monotonic): error: 466 ns, adjusted frequency from 2299774591 Hz to 2299775830 Hz D0321 12:23:40.437917 5513 parameters.go:238] Clock(Realtime): error: 80 ns, adjusted frequency from 2299773911 Hz to 2299774829 Hz D0321 12:23:40.438100 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712698583768120 monotonicBaseRef:74000320396 monotonicFrequency:2299775830 realtimeReady:1 realtimeBaseCycles:1712698584476752 realtimeBaseRef:1584793420437908202 realtimeFrequency:2299774829} D0321 12:23:41.437564 5513 parameters.go:238] Clock(Monotonic): error: -574 ns, adjusted frequency from 2299775830 Hz to 2299773399 Hz D0321 12:23:41.437780 5513 parameters.go:238] Clock(Realtime): error: 74 ns, adjusted frequency from 2299774829 Hz to 2299774792 Hz D0321 12:23:41.437929 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712700883418417 monotonicBaseRef:75000265811 monotonicFrequency:2299773399 realtimeReady:1 realtimeBaseCycles:1712700883933688 realtimeBaseRef:1584793421437769974 realtimeFrequency:2299774792} D0321 12:23:42.437857 5513 parameters.go:238] Clock(Monotonic): error: -26 ns, adjusted frequency from 2299773399 Hz to 2299774709 Hz D0321 12:23:42.438114 5513 parameters.go:238] Clock(Realtime): error: -214 ns, adjusted frequency from 2299774792 Hz to 2299774176 Hz D0321 12:23:42.438268 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712703183794439 monotonicBaseRef:76000527846 monotonicFrequency:2299774709 realtimeReady:1 realtimeBaseCycles:1712703184484818 realtimeBaseRef:1584793422438107545 realtimeFrequency:2299774176} D0321 12:23:43.437586 5513 parameters.go:238] Clock(Monotonic): error: 150 ns, adjusted frequency from 2299774709 Hz to 2299775001 Hz D0321 12:23:43.438581 5513 parameters.go:238] Clock(Realtime): error: 421 ns, adjusted frequency from 2299774176 Hz to 2299775573 Hz D0321 12:23:43.438698 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712705483014050 monotonicBaseRef:77000286475 monotonicFrequency:2299775001 realtimeReady:1 realtimeBaseCycles:1712705485329440 realtimeBaseRef:1584793423438573002 realtimeFrequency:2299775573} D0321 12:23:44.437661 5513 parameters.go:238] Clock(Monotonic): error: -76 ns, adjusted frequency from 2299775001 Hz to 2299774543 Hz D0321 12:23:44.437938 5513 parameters.go:238] Clock(Realtime): error: 161 ns, adjusted frequency from 2299775573 Hz to 2299774986 Hz D0321 12:23:44.438118 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712707782960679 monotonicBaseRef:78000361103 monotonicFrequency:2299774543 realtimeReady:1 realtimeBaseCycles:1712707783616462 realtimeBaseRef:1584793424437925742 realtimeFrequency:2299774986} D0321 12:23:45.437592 5513 parameters.go:238] Clock(Monotonic): error: 34 ns, adjusted frequency from 2299774543 Hz to 2299774638 Hz D0321 12:23:45.437794 5513 parameters.go:238] Clock(Realtime): error: -461 ns, adjusted frequency from 2299774986 Hz to 2299773589 Hz D0321 12:23:45.437958 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712710082590700 monotonicBaseRef:79000298261 monotonicFrequency:2299774638 realtimeReady:1 realtimeBaseCycles:1712710083075201 realtimeBaseRef:1584793425437788229 realtimeFrequency:2299773589} D0321 12:23:46.437580 5513 parameters.go:238] Clock(Monotonic): error: 282 ns, adjusted frequency from 2299774638 Hz to 2299775222 Hz D0321 12:23:46.437871 5513 parameters.go:238] Clock(Realtime): error: 89 ns, adjusted frequency from 2299773589 Hz to 2299774918 Hz D0321 12:23:46.438046 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712712382297884 monotonicBaseRef:80000268930 monotonicFrequency:2299775222 realtimeReady:1 realtimeBaseCycles:1712712383023495 realtimeBaseRef:1584793426437864195 realtimeFrequency:2299774918} D0321 12:23:47.437550 5513 parameters.go:238] Clock(Monotonic): error: -301 ns, adjusted frequency from 2299775222 Hz to 2299773816 Hz D0321 12:23:47.437737 5513 parameters.go:238] Clock(Realtime): error: -230 ns, adjusted frequency from 2299774918 Hz to 2299774094 Hz D0321 12:23:47.437887 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712714682034789 monotonicBaseRef:81000252268 monotonicFrequency:2299773816 realtimeReady:1 realtimeBaseCycles:1712714682495503 realtimeBaseRef:1584793427437732482 realtimeFrequency:2299774094} D0321 12:23:48.438106 5513 parameters.go:238] Clock(Monotonic): error: 422 ns, adjusted frequency from 2299773816 Hz to 2299775566 Hz D0321 12:23:48.438353 5513 parameters.go:238] Clock(Realtime): error: 177 ns, adjusted frequency from 2299774094 Hz to 2299775059 Hz D0321 12:23:48.438449 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712716983092759 monotonicBaseRef:82000810650 monotonicFrequency:2299775566 realtimeReady:1 realtimeBaseCycles:1712716983685811 realtimeBaseRef:1584793428438348287 realtimeFrequency:2299775059} D0321 12:23:49.437557 5513 parameters.go:238] Clock(Monotonic): error: -418 ns, adjusted frequency from 2299775566 Hz to 2299773609 Hz D0321 12:23:49.438245 5513 parameters.go:238] Clock(Realtime): error: 86 ns, adjusted frequency from 2299775059 Hz to 2299774842 Hz D0321 12:23:49.438340 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712719281590535 monotonicBaseRef:83000255034 monotonicFrequency:2299773609 realtimeReady:1 realtimeBaseCycles:1712719283209620 realtimeBaseRef:1584793429438239037 realtimeFrequency:2299774842} D0321 12:23:50.437540 5513 parameters.go:238] Clock(Monotonic): error: 466 ns, adjusted frequency from 2299773609 Hz to 2299775638 Hz D0321 12:23:50.437833 5513 parameters.go:238] Clock(Realtime): error: 182 ns, adjusted frequency from 2299774842 Hz to 2299775053 Hz D0321 12:23:50.437989 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712721581286829 monotonicBaseRef:84000221415 monotonicFrequency:2299775638 realtimeReady:1 realtimeBaseCycles:1712721582032168 realtimeBaseRef:1584793430437824955 realtimeFrequency:2299775053} I0321 12:23:51.007073 7040 main.go:305] *************************** I0321 12:23:51.007248 7040 main.go:306] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=ptrace -file-access=shared -network=sandbox -TESTONLY-unsafe-nonroot exec -user=0:0 -cap CAP_CHOWN -cap CAP_DAC_OVERRIDE -cap CAP_DAC_READ_SEARCH -cap CAP_FOWNER -cap CAP_FSETID -cap CAP_KILL -cap CAP_SETGID -cap CAP_SETUID -cap CAP_SETPCAP -cap CAP_LINUX_IMMUTABLE -cap CAP_NET_BIND_SERVICE -cap CAP_NET_BROADCAST -cap CAP_NET_ADMIN -cap CAP_NET_RAW -cap CAP_IPC_LOCK -cap CAP_IPC_OWNER -cap CAP_SYS_MODULE -cap CAP_SYS_RAWIO -cap CAP_SYS_CHROOT -cap CAP_SYS_PTRACE -cap CAP_SYS_PACCT -cap CAP_SYS_ADMIN -cap CAP_SYS_BOOT -cap CAP_SYS_NICE -cap CAP_SYS_RESOURCE -cap CAP_SYS_TIME -cap CAP_SYS_TTY_CONFIG -cap CAP_MKNOD -cap CAP_LEASE -cap CAP_AUDIT_WRITE -cap CAP_AUDIT_CONTROL -cap CAP_SETFCAP -cap CAP_MAC_OVERRIDE -cap CAP_MAC_ADMIN -cap CAP_SYSLOG -cap CAP_WAKE_ALARM -cap CAP_BLOCK_SUSPEND -cap CAP_AUDIT_READ ci-gvisor-ptrace-proxy-sandbox-race-2 /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller892890280] I0321 12:23:51.007870 7040 main.go:307] Version release-20200219.0-214-gd5fe1ce0c1c5 I0321 12:23:51.008003 7040 main.go:308] PID: 7040 I0321 12:23:51.008119 7040 main.go:309] UID: 0, GID: 0 I0321 12:23:51.008242 7040 main.go:310] Configuration: I0321 12:23:51.008319 7040 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0321 12:23:51.008411 7040 main.go:312] Platform: ptrace I0321 12:23:51.008490 7040 main.go:313] FileAccess: shared, overlay: false I0321 12:23:51.008617 7040 main.go:314] Network: sandbox, logging: false I0321 12:23:51.008715 7040 main.go:315] Strace: false, max size: 1024, syscalls: [] I0321 12:23:51.008893 7040 main.go:316] *************************** W0321 12:23:51.008997 7040 main.go:321] Block the TERM signal. This is only safe in tests! D0321 12:23:51.009476 7040 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.017373 7040 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0321 12:23:51.017552 7040 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.017641 7040 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.018138 7040 urpc.go:534] urpc: successfully marshalled 117 bytes. D0321 12:23:51.018535 5513 urpc.go:577] urpc: unmarshal success. D0321 12:23:51.018808 5513 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0321 12:23:51.020260 5513 urpc.go:534] urpc: successfully marshalled 37 bytes. D0321 12:23:51.020614 7040 urpc.go:577] urpc: unmarshal success. D0321 12:23:51.020753 7040 exec.go:120] Exec arguments: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller892890280 D0321 12:23:51.020952 7040 exec.go:121] Exec capablities: &{PermittedCaps:274877898751 InheritableCaps:274877898751 EffectiveCaps:274877898751 BoundingCaps:274877898751 AmbientCaps:0} D0321 12:23:51.021161 7040 container.go:533] Execute in container "ci-gvisor-ptrace-proxy-sandbox-race-2", args: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller892890280 D0321 12:23:51.021376 7040 sandbox.go:283] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-2" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.021549 7040 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.022651 7040 urpc.go:534] urpc: successfully marshalled 636 bytes. D0321 12:23:51.023979 5513 urpc.go:577] urpc: unmarshal success. D0321 12:23:51.025229 5513 controller.go:270] containerManager.ExecuteAsync: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller892890280 D0321 12:23:51.025568 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [etc]} D0321 12:23:51.026193 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.026414 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0321 12:23:51.027168 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} I0321 12:23:51.027617 5513 kernel.go:807] EXEC: [/syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=1 -repeat=1 -threaded=false -collide=false -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller892890280] D0321 12:23:51.029976 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 5, Names: [syz-execprog]} D0321 12:23:51.031810 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] 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: 1584770831, NanoSec: 686196562}, MTime: {Sec: 1584770831, NanoSec: 686196562}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 13370052}]} D0321 12:23:51.032818 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-execprog, Size: 1} D0321 12:23:51.033401 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.033807 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetattr{FID: 5, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0321 12:23:51.034930 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 13370052}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 24180480, BlockSize: 4096, Blocks: 47232, ATime: {Sec: 1584770831, NanoSec: 686196562}, MTime: {Sec: 1584770831, NanoSec: 686196562}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0321 12:23:51.035154 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalk{FID: 5, NewFID: 6, Names: []} D0321 12:23:51.036118 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rwalk{QIDs: []} D0321 12:23:51.036271 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tlopen{FID: 6, Flags: ReadOnly} D0321 12:23:51.037226 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 13370052}, IoUnit: 0, File: &{{37}}} D0321 12:23:51.043627 5513 syscalls.go:266] Allocating stack with size of 8388608 bytes D0321 12:23:51.045491 5513 loader.go:832] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-2 0}:0xc0004806a0 {ci-gvisor-ptrace-proxy-sandbox-race-2 20}:0xc000600000] D0321 12:23:51.045815 5513 urpc.go:534] urpc: successfully marshalled 37 bytes. D0321 12:23:51.046010 7040 urpc.go:577] urpc: unmarshal success. D0321 12:23:51.046199 7040 container.go:580] Wait on PID 20 in container "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.046339 7040 sandbox.go:769] Waiting for PID 20 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.046475 7040 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:51.046912 7040 urpc.go:534] urpc: successfully marshalled 100 bytes. D0321 12:23:51.047528 5513 urpc.go:577] urpc: unmarshal success. D0321 12:23:51.048406 5513 controller.go:446] containerManager.Wait D0321 12:23:51.051514 5513 task_block.go:223] [ 20] Interrupt queued D0321 12:23:51.372185 5513 task_block.go:223] [ 21] Interrupt queued D0321 12:23:51.374942 5513 task_block.go:223] [ 22] Interrupt queued D0321 12:23:51.393748 5513 task_block.go:223] [ 23] Interrupt queued D0321 12:23:51.403706 5513 task_block.go:223] [ 24] Interrupt queued D0321 12:23:51.438494 5513 parameters.go:238] Clock(Monotonic): error: -333 ns, adjusted frequency from 2299775638 Hz to 2299773870 Hz D0321 12:23:51.438727 5513 parameters.go:238] Clock(Realtime): error: -157 ns, adjusted frequency from 2299775053 Hz to 2299774242 Hz D0321 12:23:51.438866 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712723883313998 monotonicBaseRef:85001200437 monotonicFrequency:2299773870 realtimeReady:1 realtimeBaseCycles:1712723883866790 realtimeBaseRef:1584793431438720507 realtimeFrequency:2299774242} D0321 12:23:51.446355 5513 urpc.go:577] urpc: unmarshal success. D0321 12:23:51.446600 5513 controller.go:504] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-2 Signo:0 PID:0 Mode:Process} D0321 12:23:51.446899 5513 urpc.go:534] urpc: successfully marshalled 37 bytes. D0321 12:23:51.459845 5513 task_block.go:223] [ 25] Interrupt queued D0321 12:23:51.465231 5513 task_block.go:223] [ 26] Interrupt queued D0321 12:23:51.513331 5513 task_block.go:223] [ 27] Interrupt queued D0321 12:23:51.542046 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [etc]} D0321 12:23:51.542870 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.543238 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0321 12:23:51.543834 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.616494 5513 task_block.go:223] [ 28] Interrupt queued D0321 12:23:51.658361 5513 task_block.go:223] [ 29] Interrupt queued D0321 12:23:51.659862 5513 task_block.go:223] [ 30] Interrupt queued D0321 12:23:51.668034 5513 task_block.go:223] [ 31] Interrupt queued D0321 12:23:51.702021 5513 task_block.go:223] [ 32] Interrupt queued D0321 12:23:51.731925 5513 task_block.go:223] [ 33] Interrupt queued D0321 12:23:51.768329 5513 task_block.go:223] [ 34] Interrupt queued D0321 12:23:51.773707 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 7, Names: [syzkaller892890280]} D0321 12:23:51.775259 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] 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: 214, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1584793430, NanoSec: 952656744}, MTime: {Sec: 1584793430, NanoSec: 952656744}, CTime: {Sec: 1584793430, NanoSec: 952656744}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 13369520}]} D0321 12:23:51.775781 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzkaller892890280, Size: 1} D0321 12:23:51.776386 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.776782 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetattr{FID: 7, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0321 12:23:51.777766 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 13369520}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 214, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1584793430, NanoSec: 952656744}, MTime: {Sec: 1584793430, NanoSec: 952656744}, CTime: {Sec: 1584793430, NanoSec: 952656744}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0321 12:23:51.777983 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalk{FID: 7, NewFID: 8, Names: []} D0321 12:23:51.778700 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rwalk{QIDs: []} D0321 12:23:51.778901 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tlopen{FID: 8, Flags: ReadOnly} D0321 12:23:51.779852 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 13369520}, IoUnit: 0, File: &{{31}}} D0321 12:23:51.780112 5513 task_block.go:223] [ 35] Interrupt queued D0321 12:23:51.782372 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetattr{FID: 8, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0321 12:23:51.783279 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 13369520}, Attr: Attr{Mode: 0o100600, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 214, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1584793430, NanoSec: 952656744}, MTime: {Sec: 1584793430, NanoSec: 952656744}, CTime: {Sec: 1584793430, NanoSec: 952656744}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/21 12:23:51 parsed 1 programs D0321 12:23:51.805843 5513 task_stop.go:118] [ 30] Entering internal stop (*kernel.vforkStop)(nil) D0321 12:23:51.806812 5513 task_block.go:223] [ 36] Interrupt queued D0321 12:23:51.813799 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D0321 12:23:51.821029 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] 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: 1584770833, NanoSec: 542378398}, MTime: {Sec: 1584770833, NanoSec: 542378398}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 13370195}]} D0321 12:23:51.821347 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syz-executor, Size: 1} D0321 12:23:51.821882 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.822301 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0321 12:23:51.823367 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 13370195}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1584770833, NanoSec: 542378398}, MTime: {Sec: 1584770833, NanoSec: 542378398}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0321 12:23:51.823573 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalk{FID: 9, NewFID: 10, Names: []} D0321 12:23:51.824189 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rwalk{QIDs: []} D0321 12:23:51.824329 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tlopen{FID: 10, Flags: ReadOnly} D0321 12:23:51.825276 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlopen{QID: QID{Type: 0, Version: 0, Path: 13370195}, IoUnit: 0, File: &{{32}}} D0321 12:23:51.826312 5513 syscalls.go:266] [ 36] Allocating stack with size of 8388608 bytes D0321 12:23:51.827221 5513 task_stop.go:137] [ 30] Leaving internal stop (*kernel.vforkStop)(nil) D0321 12:23:51.886103 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0321 12:23:51.886907 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.887208 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0321 12:23:51.888843 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.915353 5513 task_exit.go:221] [ 36] Transitioning from exit state TaskExitNone to TaskExitInitiated D0321 12:23:51.916833 5513 task_exit.go:221] [ 36] Transitioning from exit state TaskExitInitiated to TaskExitZombie D0321 12:23:51.917023 5513 task_signals.go:446] [ 20] Notified of signal 17 D0321 12:23:51.917145 5513 task_block.go:223] [ 20] Interrupt queued D0321 12:23:51.917202 5513 task_block.go:223] [ 20] Interrupt queued D0321 12:23:51.917477 5513 task_signals.go:179] [ 20] Restarting syscall 202 after errno 512: interrupted by signal 17 D0321 12:23:51.917632 5513 task_signals.go:220] [ 20] Signal 17: delivering to handler D0321 12:23:51.918153 5513 task_exit.go:221] [ 36] Transitioning from exit state TaskExitZombie to TaskExitDead D0321 12:23:51.921590 5513 task_block.go:223] [ 37] Interrupt queued D0321 12:23:51.924923 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0321 12:23:51.926305 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] 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: 1584770833, NanoSec: 542378398}, MTime: {Sec: 1584770833, NanoSec: 542378398}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 13370195}]} D0321 12:23:51.926475 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tclunk{FID: 11} D0321 12:23:51.927027 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rclunk{} D0321 12:23:51.927270 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0321 12:23:51.928359 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 13370195}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1584770833, NanoSec: 542378398}, MTime: {Sec: 1584770833, NanoSec: 542378398}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} 2020/03/21 12:23:51 executed programs: 0 D0321 12:23:51.943110 5513 task_stop.go:118] [ 30] Entering internal stop (*kernel.vforkStop)(nil) D0321 12:23:51.944080 5513 task_block.go:223] [ 38] Interrupt queued D0321 12:23:51.948765 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syz-executor]} D0321 12:23:51.950245 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] 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: 1584770833, NanoSec: 542378398}, MTime: {Sec: 1584770833, NanoSec: 542378398}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 13370195}]} D0321 12:23:51.950430 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tclunk{FID: 11} D0321 12:23:51.950989 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rclunk{} D0321 12:23:51.951223 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetattr{FID: 9, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D0321 12:23:51.952221 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 13370195}, Attr: Attr{Mode: 0o100755, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 1579696, BlockSize: 4096, Blocks: 3088, ATime: {Sec: 1584770833, NanoSec: 542378398}, MTime: {Sec: 1584770833, NanoSec: 542378398}, CTime: {Sec: 1584793348, NanoSec: 244552713}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D0321 12:23:51.953236 5513 syscalls.go:266] [ 38] Allocating stack with size of 8388608 bytes D0321 12:23:51.954186 5513 task_stop.go:137] [ 30] Leaving internal stop (*kernel.vforkStop)(nil) D0321 12:23:51.958497 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [etc]} D0321 12:23:51.959797 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.959976 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.etc, Size: 1} D0321 12:23:51.960479 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.973506 5513 task_block.go:223] [ 39] Interrupt queued D0321 12:23:51.979065 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.979846 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.980089 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.980740 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.982049 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.982873 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.983110 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.983634 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.984188 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.984736 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.984889 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.985414 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.985815 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.986490 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.986685 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.987252 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.987679 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.988303 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.988440 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.988970 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.989846 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.990410 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.990559 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.990967 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.991358 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.991965 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.992143 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.992696 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.993176 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.993801 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.993988 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.994598 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:51.995201 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:51.995784 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:51.995909 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:51.996593 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.054680 5513 netfilter.go:60] netfilter: convert to binary: current offset: 0 D0321 12:23:52.054853 5513 netfilter.go:60] netfilter: convert to binary: found hook 0 at offset 0 D0321 12:23:52.055060 5513 netfilter.go:60] netfilter: convert to binary: found underflow 0 at offset 0 D0321 12:23:52.055210 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.055349 5513 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]} D0321 12:23:52.056103 5513 netfilter.go:60] netfilter: convert to binary: current offset: 152 D0321 12:23:52.056226 5513 netfilter.go:60] netfilter: convert to binary: found hook 1 at offset 152 D0321 12:23:52.056336 5513 netfilter.go:60] netfilter: convert to binary: found underflow 1 at offset 152 D0321 12:23:52.056431 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.056539 5513 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]} D0321 12:23:52.057438 5513 netfilter.go:60] netfilter: convert to binary: current offset: 304 D0321 12:23:52.057550 5513 netfilter.go:60] netfilter: convert to binary: found hook 3 at offset 304 D0321 12:23:52.057630 5513 netfilter.go:60] netfilter: convert to binary: found underflow 3 at offset 304 D0321 12:23:52.057747 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.057900 5513 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]} D0321 12:23:52.058604 5513 netfilter.go:60] netfilter: convert to binary: current offset: 456 D0321 12:23:52.058774 5513 netfilter.go:60] netfilter: convert to binary: found hook 4 at offset 456 D0321 12:23:52.058861 5513 netfilter.go:60] netfilter: convert to binary: found underflow 4 at offset 456 D0321 12:23:52.059000 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.059103 5513 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]} D0321 12:23:52.059879 5513 netfilter.go:60] netfilter: convert to binary: current offset: 608 D0321 12:23:52.060009 5513 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]} D0321 12:23:52.060776 5513 netfilter.go:60] netfilter: convert to binary: finished with an marshalled size of 0 D0321 12:23:52.060926 5513 netfilter.go:60] netfilter: convert to binary: current offset: 0 D0321 12:23:52.061009 5513 netfilter.go:60] netfilter: convert to binary: found hook 0 at offset 0 D0321 12:23:52.061252 5513 netfilter.go:60] netfilter: convert to binary: found underflow 0 at offset 0 D0321 12:23:52.061416 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.061671 5513 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]} D0321 12:23:52.062445 5513 netfilter.go:60] netfilter: convert to binary: current offset: 152 D0321 12:23:52.062571 5513 netfilter.go:60] netfilter: convert to binary: found hook 3 at offset 152 D0321 12:23:52.062698 5513 netfilter.go:60] netfilter: convert to binary: found underflow 3 at offset 152 D0321 12:23:52.062808 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.062940 5513 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]} D0321 12:23:52.065069 5513 netfilter.go:60] netfilter: convert to binary: current offset: 304 D0321 12:23:52.065222 5513 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]} D0321 12:23:52.067473 5513 netfilter.go:60] netfilter: convert to binary: finished with an marshalled size of 0 D0321 12:23:52.067590 5513 netfilter.go:60] netfilter: convert to binary: current offset: 0 D0321 12:23:52.067699 5513 netfilter.go:60] netfilter: convert to binary: found hook 1 at offset 0 D0321 12:23:52.067855 5513 netfilter.go:60] netfilter: convert to binary: found underflow 1 at offset 0 D0321 12:23:52.067988 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.068107 5513 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]} D0321 12:23:52.068877 5513 netfilter.go:60] netfilter: convert to binary: current offset: 152 D0321 12:23:52.068969 5513 netfilter.go:60] netfilter: convert to binary: found hook 2 at offset 152 D0321 12:23:52.069055 5513 netfilter.go:60] netfilter: convert to binary: found underflow 2 at offset 152 D0321 12:23:52.069172 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.069281 5513 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]} D0321 12:23:52.069967 5513 netfilter.go:60] netfilter: convert to binary: current offset: 304 D0321 12:23:52.070053 5513 netfilter.go:60] netfilter: convert to binary: found hook 3 at offset 304 D0321 12:23:52.070178 5513 netfilter.go:60] netfilter: convert to binary: found underflow 3 at offset 304 D0321 12:23:52.070342 5513 netfilter.go:60] netfilter: convert to binary: marshalling standard target D0321 12:23:52.070438 5513 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]} D0321 12:23:52.071233 5513 netfilter.go:60] netfilter: convert to binary: current offset: 456 D0321 12:23:52.071394 5513 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]} D0321 12:23:52.072101 5513 netfilter.go:60] netfilter: convert to binary: finished with an marshalled size of 0 D0321 12:23:52.357846 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.358565 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.358789 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.359261 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.359774 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.360323 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.360503 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.361007 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.361409 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.362036 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.362168 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.362667 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.363022 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.363678 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.363871 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.364457 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.364921 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.365548 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.365725 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.366339 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.366689 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.367415 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.367615 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.368686 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.369049 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.377652 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.377877 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.378506 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.378927 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.379606 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.379794 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.380304 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.380604 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.381098 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.381261 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.381822 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.382090 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Twalkgetattr{FID: 1, NewFID: 11, Names: [syzcgroup]} D0321 12:23:52.383058 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 2} D0321 12:23:52.383206 5513 transport_flipcall.go:127] send [channel @0xc0003303c0] Tgetxattr{FID: 1, Name: trusted.overlay.whiteout.syzcgroup, Size: 1} D0321 12:23:52.383637 5513 transport_flipcall.go:234] recv [channel @0xc0003303c0] Rlerror{Error: 95} D0321 12:23:52.426380 5513 task_block.go:223] [ 40] Interrupt queued D0321 12:23:52.437503 5513 parameters.go:238] Clock(Monotonic): error: 181 ns, adjusted frequency from 2299773870 Hz to 2299775006 Hz D0321 12:23:52.437854 5513 parameters.go:238] Clock(Realtime): error: -53 ns, adjusted frequency from 2299774242 Hz to 2299774531 Hz D0321 12:23:52.437963 5513 timekeeper.go:209] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:1712726180478767 monotonicBaseRef:86000065933 monotonicFrequency:2299775006 realtimeReady:1 realtimeBaseCycles:1712726181625687 realtimeBaseRef:1584793432437844184 realtimeFrequency:2299774531} fatal error: too many address space collisions for -race mode DIAGNOSIS: I0321 12:23:52.529909 7173 main.go:305] *************************** I0321 12:23:52.530079 7173 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] I0321 12:23:52.530275 7173 main.go:307] Version release-20200219.0-214-gd5fe1ce0c1c5 I0321 12:23:52.530359 7173 main.go:308] PID: 7173 I0321 12:23:52.530447 7173 main.go:309] UID: 0, GID: 0 I0321 12:23:52.530515 7173 main.go:310] Configuration: I0321 12:23:52.530592 7173 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0321 12:23:52.530683 7173 main.go:312] Platform: ptrace I0321 12:23:52.530788 7173 main.go:313] FileAccess: shared, overlay: false I0321 12:23:52.530913 7173 main.go:314] Network: sandbox, logging: false I0321 12:23:52.530985 7173 main.go:315] Strace: false, max size: 1024, syscalls: [] I0321 12:23:52.531068 7173 main.go:316] *************************** W0321 12:23:52.531154 7173 main.go:321] Block the TERM signal. This is only safe in tests! D0321 12:23:52.531332 7173 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.540776 7173 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0321 12:23:52.540923 7173 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.541043 7173 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.541426 7173 urpc.go:534] urpc: successfully marshalled 117 bytes. I0321 12:23:52.681212 7173 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 5513 I0321 12:23:52.681414 7173 debug.go:137] Retrieving sandbox stacks D0321 12:23:52.681515 7173 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.681615 7173 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0321 12:23:52.681799 7173 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 5513: connection refused retrieving stacks: connecting to control server at PID 5513: connection refused W0321 12:23:52.683306 7173 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 I0321 12:23:52.529909 7173 main.go:305] *************************** I0321 12:23:52.530079 7173 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] I0321 12:23:52.530275 7173 main.go:307] Version release-20200219.0-214-gd5fe1ce0c1c5 I0321 12:23:52.530359 7173 main.go:308] PID: 7173 I0321 12:23:52.530447 7173 main.go:309] UID: 0, GID: 0 I0321 12:23:52.530515 7173 main.go:310] Configuration: I0321 12:23:52.530592 7173 main.go:311] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I0321 12:23:52.530683 7173 main.go:312] Platform: ptrace I0321 12:23:52.530788 7173 main.go:313] FileAccess: shared, overlay: false I0321 12:23:52.530913 7173 main.go:314] Network: sandbox, logging: false I0321 12:23:52.530985 7173 main.go:315] Strace: false, max size: 1024, syscalls: [] I0321 12:23:52.531068 7173 main.go:316] *************************** W0321 12:23:52.531154 7173 main.go:321] Block the TERM signal. This is only safe in tests! D0321 12:23:52.531332 7173 container.go:159] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.540776 7173 container.go:592] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-2": signal 0 D0321 12:23:52.540923 7173 sandbox.go:814] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.541043 7173 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.541426 7173 urpc.go:534] urpc: successfully marshalled 117 bytes. I0321 12:23:52.681212 7173 debug.go:128] Found sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2", PID: 5513 I0321 12:23:52.681414 7173 debug.go:137] Retrieving sandbox stacks D0321 12:23:52.681515 7173 sandbox.go:932] Stacks sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" D0321 12:23:52.681615 7173 sandbox.go:318] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-2" W0321 12:23:52.681799 7173 error.go:48] FATAL ERROR: retrieving stacks: connecting to control server at PID 5513: connection refused retrieving stacks: connecting to control server at PID 5513: connection refused W0321 12:23:52.683306 7173 main.go:338] Failure to execute command, err: 1 [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] [] ? _raw_spin_lock+0x1d/0x20 [303040.008369] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.008373] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008387] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.008391] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008405] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008419] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.008420] [] ? recalc_sigpending+0x17/0x50 [303040.008433] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008435] [] ? signal_setup_done+0x67/0xb0 [303040.008436] [] ? __seccomp_filter+0x74/0x270 [303040.008438] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008440] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008442] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008443] [] ? SyS_ioctl+0x74/0x80 [303040.008445] [] ? do_syscall_64+0x8d/0x100 [303040.008447] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008448] Task dump for CPU 9: [303040.008450] exe R running task 0 4036 60665 0x00000988 [303040.008452] ffffffffa0ec6eef 0000000000000010 0000000000000202 ffffba196ab7fbf0 [303040.008454] 0000000000000018 ffffffffa141e2fd ffffffffc0908f1b ffffba196ab7fc27 [303040.008456] ffffffffc09cf00c 0000000100000000 000000000001d0d8 0001ffffc09cf018 [303040.008456] Call Trace: [303040.008458] [] ? native_queued_spin_lock_slowpath+0x1f/0x1a0 [303040.008459] [] ? _raw_spin_lock+0x1d/0x20 [303040.008473] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.008477] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008490] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.008494] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008508] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008522] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.008523] [] ? recalc_sigpending+0x17/0x50 [303040.008536] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008537] [] ? signal_setup_done+0x67/0xb0 [303040.008539] [] ? __seccomp_filter+0x74/0x270 [303040.008541] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008542] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008544] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008546] [] ? SyS_ioctl+0x74/0x80 [303040.008547] [] ? do_syscall_64+0x8d/0x100 [303040.008549] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008550] Task dump for CPU 17: [303040.008552] exe R running task 0 60696 60665 0x00000988 [303040.008554] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.008556] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.008557] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.008557] Call Trace: [303040.008561] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008564] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008567] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008570] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008573] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008576] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008579] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008582] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008584] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008588] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.008601] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008615] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.008616] [] ? recalc_sigpending+0x17/0x50 [303040.008631] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008632] [] ? signal_setup_done+0x67/0xb0 [303040.008634] [] ? __seccomp_filter+0x74/0x270 [303040.008635] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008637] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008639] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008640] [] ? SyS_ioctl+0x74/0x80 [303040.008642] [] ? do_syscall_64+0x8d/0x100 [303040.008644] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008644] Task dump for CPU 20: [303040.008646] exe R running task 0 60724 60665 0x00000988 [303040.008648] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.008650] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.008651] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.008652] Call Trace: [303040.008655] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008659] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008661] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008665] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008668] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008670] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008674] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008676] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008679] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008683] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.008698] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008712] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303040.008713] [] ? recalc_sigpending+0x17/0x50 [303040.008725] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008727] [] ? signal_setup_done+0x67/0xb0 [303040.008728] [] ? __seccomp_filter+0x74/0x270 [303040.008730] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008732] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008733] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008735] [] ? SyS_ioctl+0x74/0x80 [303040.008736] [] ? do_syscall_64+0x8d/0x100 [303040.008738] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008739] Task dump for CPU 32: [303040.008741] exe R running task 0 4116 60665 0x00000988 [303040.008742] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [303040.008744] ffffba196b057de8 ffff9fbd40012000 0000000000000000 0000000000000000 [303040.008746] 0000000000000000 0000000000000000 ffff9faff3c3d140 0002799b30d258e5 [303040.008746] Call Trace: [303040.008749] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008763] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008776] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.008777] [] ? recalc_sigpending+0x17/0x50 [303040.008790] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008791] [] ? signal_setup_done+0x67/0xb0 [303040.008793] [] ? __seccomp_filter+0x74/0x270 [303040.008794] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008796] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008797] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008799] [] ? SyS_ioctl+0x74/0x80 [303040.008801] [] ? do_syscall_64+0x8d/0x100 [303040.008802] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008803] Task dump for CPU 33: [303040.008805] exe R running task 0 4112 60665 0x00000988 [303040.008807] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.008809] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.008810] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.008810] Call Trace: [303040.008814] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008816] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008819] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008822] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008825] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008828] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008831] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008834] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.008837] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.008840] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.008853] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008867] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.008868] [] ? recalc_sigpending+0x17/0x50 [303040.008881] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008882] [] ? signal_setup_done+0x67/0xb0 [303040.008884] [] ? __seccomp_filter+0x74/0x270 [303040.008886] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008888] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008890] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008891] [] ? SyS_ioctl+0x74/0x80 [303040.008893] [] ? do_syscall_64+0x8d/0x100 [303040.008894] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008895] Task dump for CPU 42: [303040.008897] exe R running task 0 4000 60665 0x00000988 [303040.008899] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [303040.008900] ffffba196a92fde8 ffff9fb24e339e80 0000000000000000 0000000000000000 [303040.008902] 0000000000000000 0000000000000000 ffff9faf3bf48000 0002799b31d950a2 [303040.008902] Call Trace: [303040.008905] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.008920] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.008933] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.008935] [] ? recalc_sigpending+0x17/0x50 [303040.008947] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.008949] [] ? signal_setup_done+0x67/0xb0 [303040.008950] [] ? __seccomp_filter+0x74/0x270 [303040.008952] [] ? do_vfs_ioctl+0xa2/0x620 [303040.008953] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.008955] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.008957] [] ? SyS_ioctl+0x74/0x80 [303040.008958] [] ? do_syscall_64+0x8d/0x100 [303040.008960] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.008960] Task dump for CPU 45: [303040.008962] exe R running task 0 9811 60665 0x00000188 [303040.008964] 0000000000785fff 00003ffffffff000 0000000000786000 ffffff8000000000 [303040.008966] 0000008000000000 0000000000785fff ffff9fc0b95f6000 0000000000786000 [303040.008967] 0000000000000287 00000001a0e526f6 ffffba197bd07b40 0000000000000287 [303040.008968] Call Trace: [303040.008981] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [303040.008982] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.008984] [] ? _raw_spin_lock+0x1d/0x20 [303040.008998] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.009001] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009015] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.009019] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009032] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009046] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009047] [] ? recalc_sigpending+0x17/0x50 [303040.009059] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009061] [] ? signal_setup_done+0x67/0xb0 [303040.009062] [] ? __seccomp_filter+0x74/0x270 [303040.009064] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009066] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009067] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009069] [] ? SyS_ioctl+0x74/0x80 [303040.009070] [] ? do_syscall_64+0x8d/0x100 [303040.009072] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009073] Task dump for CPU 52: [303040.009075] exe R running task 0 3972 60665 0x00000988 [303040.009077] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.009079] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.009081] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.009081] Call Trace: [303040.009085] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009088] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009091] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009094] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009097] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009100] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009103] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009106] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009109] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009112] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.009130] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009143] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009145] [] ? recalc_sigpending+0x17/0x50 [303040.009157] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009159] [] ? signal_setup_done+0x67/0xb0 [303040.009160] [] ? __seccomp_filter+0x74/0x270 [303040.009162] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009164] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009165] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009167] [] ? SyS_ioctl+0x74/0x80 [303040.009168] [] ? do_syscall_64+0x8d/0x100 [303040.009170] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009171] Task dump for CPU 59: [303040.009173] exe R running task 0 60695 60665 0x00000188 [303040.009175] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [303040.009177] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [303040.009178] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [303040.009178] Call Trace: [303040.009182] [] ? vfs_fallocate+0x15a/0x220 [303040.009183] [] ? SyS_fallocate+0x43/0x80 [303040.009185] [] ? do_syscall_64+0x8d/0x100 [303040.009187] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009187] Task dump for CPU 60: [303040.009189] exe R running task 0 3983 60665 0x00000188 [303040.009191] 0000000000883fff 00003ffffffff000 0000000000884000 ffffff8000000000 [303040.009193] 0000008000000000 0000000000883fff ffff9fc0b95f6000 0000000000884000 [303040.009194] 0000000000000287 0000000100000001 ffffba196a85fb40 0000000000000287 [303040.009195] Call Trace: [303040.009208] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [303040.009209] [] ? __switch_to_asm+0x35/0x70 [303040.009211] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.009212] [] ? _raw_spin_lock+0x1d/0x20 [303040.009227] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.009230] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009244] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.009248] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009261] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009275] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009276] [] ? recalc_sigpending+0x17/0x50 [303040.009288] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009290] [] ? signal_setup_done+0x67/0xb0 [303040.009292] [] ? __seccomp_filter+0x74/0x270 [303040.009293] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009295] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009297] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009299] [] ? SyS_ioctl+0x74/0x80 [303040.009301] [] ? do_syscall_64+0x8d/0x100 [303040.009302] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009304] Task dump for CPU 0: [303040.009306] exe R running task 0 9806 60665 0x00000988 [303040.009308] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.009310] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.009311] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.009312] Call Trace: [303040.009316] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009319] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009322] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009325] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009327] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009330] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009333] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009336] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009339] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009342] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.009355] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009371] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303040.009372] [] ? recalc_sigpending+0x17/0x50 [303040.009385] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009386] [] ? signal_setup_done+0x67/0xb0 [303040.009388] [] ? __seccomp_filter+0x74/0x270 [303040.009389] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009391] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009392] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009394] [] ? SyS_ioctl+0x74/0x80 [303040.009395] [] ? do_syscall_64+0x8d/0x100 [303040.009397] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009398] Task dump for CPU 8: [303040.009399] exe R running task 0 4291 60665 0x00000188 [303040.009401] 00000000007ccfff 00003ffffffff000 00000000007cd000 ffffff8000000000 [303040.009403] 0000008000000000 00000000007ccfff ffff9fc0b95f6000 00000000007cd000 [303040.009404] 0000000000000287 00000001000fe000 ffffba196b5f7b40 0000000000000287 [303040.009404] Call Trace: [303040.009417] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [303040.009419] [] ? entry_SYSCALL_64_after_swapgs+0x8a/0xc6 [303040.009421] [] ? __switch_to_asm+0x35/0x70 [303040.009422] [] ? __switch_to_asm+0x41/0x70 [303040.009424] [] ? __switch_to_asm+0x35/0x70 [303040.009425] [] ? __switch_to_asm+0x35/0x70 [303040.009427] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.009428] [] ? _raw_spin_lock+0x1d/0x20 [303040.009443] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.009446] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009459] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.009463] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009476] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009490] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009491] [] ? recalc_sigpending+0x17/0x50 [303040.009504] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009505] [] ? signal_setup_done+0x67/0xb0 [303040.009507] [] ? __seccomp_filter+0x74/0x270 [303040.009508] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009511] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009512] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009514] [] ? SyS_ioctl+0x74/0x80 [303040.009516] [] ? do_syscall_64+0x8d/0x100 [303040.009518] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009518] Task dump for CPU 9: [303040.009520] exe R running task 0 4036 60665 0x00000988 [303040.009522] ffffffffa0ec6eef 0000000000000010 0000000000000202 ffffba196ab7fbf0 [303040.009523] 0000000000000018 ffffffffa141e2fd ffffffffc0908f1b ffffba196ab7fc27 [303040.009525] ffffffffc09cf00c 0000000100000000 000000000001d0d8 0001ffffc09cf018 [303040.009525] Call Trace: [303040.009526] [] ? native_queued_spin_lock_slowpath+0x1f/0x1a0 [303040.009528] [] ? _raw_spin_lock+0x1d/0x20 [303040.009542] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.009545] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009558] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.009561] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009575] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009588] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009589] [] ? recalc_sigpending+0x17/0x50 [303040.009602] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009603] [] ? signal_setup_done+0x67/0xb0 [303040.009605] [] ? __seccomp_filter+0x74/0x270 [303040.009606] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009608] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009610] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009611] [] ? SyS_ioctl+0x74/0x80 [303040.009613] [] ? do_syscall_64+0x8d/0x100 [303040.009615] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009615] Task dump for CPU 17: [303040.009617] exe R running task 0 60696 60665 0x00000988 [303040.009623] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.009624] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.009626] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.009626] Call Trace: [303040.009630] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009632] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009635] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009638] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009641] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009644] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009647] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009650] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009653] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009656] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.009669] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009682] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009683] [] ? recalc_sigpending+0x17/0x50 [303040.009696] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009697] [] ? signal_setup_done+0x67/0xb0 [303040.009699] [] ? __seccomp_filter+0x74/0x270 [303040.009700] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009702] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009704] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009705] [] ? SyS_ioctl+0x74/0x80 [303040.009707] [] ? do_syscall_64+0x8d/0x100 [303040.009708] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009709] Task dump for CPU 20: [303040.009711] exe R running task 0 60724 60665 0x00000988 [303040.009713] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.009714] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.009716] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.009717] Call Trace: [303040.009720] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009723] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009728] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009731] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009733] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009736] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009739] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009742] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009745] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009748] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.009761] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009774] [] ? kvm_arch_vcpu_load+0x100/0x290 [kvm] [303040.009775] [] ? recalc_sigpending+0x17/0x50 [303040.009788] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009789] [] ? signal_setup_done+0x67/0xb0 [303040.009791] [] ? __seccomp_filter+0x74/0x270 [303040.009793] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009794] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009796] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009797] [] ? SyS_ioctl+0x74/0x80 [303040.009799] [] ? do_syscall_64+0x8d/0x100 [303040.009801] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009801] Task dump for CPU 32: [303040.009803] exe R running task 0 4116 60665 0x00000988 [303040.009804] ffffffffa1b19a00 ffffffffa0ea953b 0000000000000020 ffffffffa1b19a00 [303040.009806] ffffffffa0f830ad ffff9fca86e196c0 ffffffffa1a4fd80 0000000000000000 [303040.009807] ffffffffa1b19a00 00000000ffffffff ffffffffa0ee51ca 0000000002bb80c3 [303040.009808] Call Trace: [303040.009810] [303040.009810] [] ? sched_show_task+0xcb/0x130 [303040.009812] [] ? rcu_dump_cpu_stacks+0x92/0xb2 [303040.009814] [] ? rcu_check_callbacks+0x75a/0x8b0 [303040.009816] [] ? tick_sched_do_timer+0x30/0x30 [303040.009818] [] ? update_process_times+0x28/0x50 [303040.009820] [] ? tick_sched_handle.isra.12+0x20/0x50 [303040.009821] [] ? tick_sched_timer+0x38/0x70 [303040.009823] [] ? __hrtimer_run_queues+0xde/0x250 [303040.009824] [] ? hrtimer_interrupt+0x9c/0x1a0 [303040.009826] [] ? smp_apic_timer_interrupt+0x47/0x60 [303040.009828] [] ? apic_timer_interrupt+0x9e/0xb0 [303040.009830] [303040.009830] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.009832] [] ? _raw_spin_lock+0x1d/0x20 [303040.009846] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.009849] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009862] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.009866] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009879] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009892] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009894] [] ? recalc_sigpending+0x17/0x50 [303040.009906] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009908] [] ? signal_setup_done+0x67/0xb0 [303040.009909] [] ? __seccomp_filter+0x74/0x270 [303040.009912] [] ? do_vfs_ioctl+0xa2/0x620 [303040.009914] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.009915] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.009917] [] ? SyS_ioctl+0x74/0x80 [303040.009918] [] ? do_syscall_64+0x8d/0x100 [303040.009920] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.009921] Task dump for CPU 33: [303040.009922] exe R running task 0 4112 60665 0x00000988 [303040.009924] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.009925] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.009927] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.009927] Call Trace: [303040.009930] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.009933] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009936] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009939] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009942] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009945] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009948] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009951] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.009953] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.009956] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.009970] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.009983] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.009984] [] ? recalc_sigpending+0x17/0x50 [303040.009997] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.009998] [] ? signal_setup_done+0x67/0xb0 [303040.010000] [] ? __seccomp_filter+0x74/0x270 [303040.010001] [] ? do_vfs_ioctl+0xa2/0x620 [303040.010003] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.010005] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.010006] [] ? SyS_ioctl+0x74/0x80 [303040.010008] [] ? do_syscall_64+0x8d/0x100 [303040.010009] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.010010] Task dump for CPU 42: [303040.010012] exe R running task 0 4000 60665 0x00000988 [303040.010013] 0000000000000000 0000000000000030 ffffffffc09dc3b1 0000000000000000 [303040.010015] ffffba196a92fde8 ffff9fb24e339e80 0000000000000000 0000000000000000 [303040.010016] 0000000000000000 0000000000000000 ffff9faf3bf48000 0002799b31d950a2 [303040.010017] Call Trace: [303040.010020] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.010035] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.010049] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.010050] [] ? recalc_sigpending+0x17/0x50 [303040.010062] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.010064] [] ? signal_setup_done+0x67/0xb0 [303040.010065] [] ? __seccomp_filter+0x74/0x270 [303040.010067] [] ? do_vfs_ioctl+0xa2/0x620 [303040.010069] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.010070] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.010072] [] ? SyS_ioctl+0x74/0x80 [303040.010073] [] ? do_syscall_64+0x8d/0x100 [303040.010075] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.010076] Task dump for CPU 45: [303040.010077] exe R running task 0 9811 60665 0x00000188 [303040.010079] 0000000000785fff 00003ffffffff000 0000000000786000 ffffff8000000000 [303040.010081] 0000008000000000 0000000000785fff ffff9fc0b95f6000 0000000000786000 [303040.010082] 0000000000000287 00000001a0e526f6 ffffba197bd07b40 0000000000000287 [303040.010083] Call Trace: [303040.010096] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [303040.010098] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.010100] [] ? _raw_spin_lock+0x1d/0x20 [303040.010114] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.010118] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.010132] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.010135] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.010148] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.010162] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.010163] [] ? recalc_sigpending+0x17/0x50 [303040.010175] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.010177] [] ? signal_setup_done+0x67/0xb0 [303040.010178] [] ? __seccomp_filter+0x74/0x270 [303040.010180] [] ? do_vfs_ioctl+0xa2/0x620 [303040.010182] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.010183] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.010185] [] ? SyS_ioctl+0x74/0x80 [303040.010186] [] ? do_syscall_64+0x8d/0x100 [303040.010188] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.010189] Task dump for CPU 52: [303040.010190] exe R running task 0 3972 60665 0x00000988 [303040.010192] 0000000000000000 0000000000000030 ffffffffc09dc3b1 ffffffffc09cf018 [303040.010193] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09cf018 [303040.010195] ffffffffc09cf00c ffffffffc09cf018 ffffffffc09cf00c ffffffffc09e0baf [303040.010195] Call Trace: [303040.010199] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.010202] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.010204] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.010207] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.010210] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.010213] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.010216] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.010219] [] ? vmexit_fill_RSB+0x18/0x30 [kvm_intel] [303040.010222] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.010225] [] ? vmx_vcpu_run+0x33f/0x4f0 [kvm_intel] [303040.010238] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.010252] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.010253] [] ? recalc_sigpending+0x17/0x50 [303040.010265] [] ? kvm_vcpu_ioctl+0x315/0x5e0 [kvm] [303040.010267] [] ? signal_setup_done+0x67/0xb0 [303040.010268] [] ? __seccomp_filter+0x74/0x270 [303040.010270] [] ? do_vfs_ioctl+0xa2/0x620 [303040.010272] [] ? __audit_syscall_entry+0xaa/0xf0 [303040.010273] [] ? syscall_trace_enter+0x1ae/0x2c0 [303040.010275] [] ? SyS_ioctl+0x74/0x80 [303040.010276] [] ? do_syscall_64+0x8d/0x100 [303040.010278] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.010279] Task dump for CPU 59: [303040.010280] exe R running task 0 60695 60665 0x00000188 [303040.010282] ffffba19514ebe58 00000000000012fb 00000000000012fd 0000000000000000 [303040.010283] 000000000000011d dc2873c05e17114b 0000000000000003 0000000000002000 [303040.010285] ffff9fb233e25288 ffff9fca730e3400 0000000000000000 00000000012fb000 [303040.010285] Call Trace: [303040.010287] [] ? vfs_fallocate+0x15a/0x220 [303040.010289] [] ? SyS_fallocate+0x43/0x80 [303040.010291] [] ? do_syscall_64+0x8d/0x100 [303040.010293] [] ? entry_SYSCALL_64_after_swapgs+0x58/0xc6 [303040.010294] Task dump for CPU 60: [303040.010295] exe R running task 0 3983 60665 0x00000188 [303040.010297] 0000000000883fff 00003ffffffff000 0000000000884000 ffffff8000000000 [303040.010298] 0000008000000000 0000000000883fff ffff9fc0b95f6000 0000000000884000 [303040.010300] 0000000000000287 0000000100000001 ffffba196a85fb40 0000000000000287 [303040.010300] Call Trace: [303040.010313] [] ? __gfn_to_pfn_memslot+0x39e/0x410 [kvm] [303040.010315] [] ? __switch_to_asm+0x35/0x70 [303040.010317] [] ? native_queued_spin_lock_slowpath+0x21/0x1a0 [303040.010318] [] ? _raw_spin_lock+0x1d/0x20 [303040.010340] [] ? tdp_page_fault+0x22b/0x2c0 [kvm] [303040.010343] [] ? vmexit_fill_RSB+0xc/0x30 [kvm_intel] [303040.010357] [] ? kvm_mmu_page_fault+0x5f/0x120 [kvm] [303040.010360] [] ? vmx_handle_exit+0x1d1/0x1680 [kvm_intel] [303040.010375] [] ? kvm_arch_vcpu_ioctl_run+0x801/0x16d0 [kvm] [303040.010389] [] ? kvm_arch_vcpu_load+0x61/0x290 [kvm] [303040.010390] [] ? recalc_sigpendi