I1218 14:56:59.567948 10950 x:0] CalibratedClock(Monotonic): ready I1218 14:56:59.568127 10950 x:0] CalibratedClock(Realtime): ready D1218 14:56:59.568160 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559463638032547 monotonicBaseRef:1000275490 monotonicFrequency:2299804353 realtimeReady:1 realtimeBaseCycles:15559463638507151 realtimeBaseRef:1545145019568122049 realtimeFrequency:2299804231} D1218 14:57:00.567914 10950 x:0] Clock(Monotonic): error: 203 ns, adjusted frequency from 2299804353 Hz to 2299805057 Hz D1218 14:57:00.568140 10950 x:0] Clock(Realtime): error: 429 ns, adjusted frequency from 2299804231 Hz to 2299805646 Hz D1218 14:57:00.568232 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559465937755409 monotonicBaseRef:2000240056 monotonicFrequency:2299805057 realtimeReady:1 realtimeBaseCycles:15559465938335668 realtimeBaseRef:1545145020568132609 realtimeFrequency:2299805646} D1218 14:57:01.567859 10950 x:0] Clock(Monotonic): error: 160 ns, adjusted frequency from 2299805057 Hz to 2299805052 Hz D1218 14:57:01.568039 10950 x:0] Clock(Realtime): error: -110 ns, adjusted frequency from 2299805646 Hz to 2299804441 Hz D1218 14:57:01.568100 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559468237468279 monotonicBaseRef:3000199971 monotonicFrequency:2299805052 realtimeReady:1 realtimeBaseCycles:15559468237913969 realtimeBaseRef:1545145021568033754 realtimeFrequency:2299804441} D1218 14:57:02.567877 10950 x:0] Clock(Monotonic): error: -11 ns, adjusted frequency from 2299805052 Hz to 2299804741 Hz D1218 14:57:02.567985 10950 x:0] Clock(Realtime): error: 125 ns, adjusted frequency from 2299804441 Hz to 2299805036 Hz D1218 14:57:02.568025 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559470537302092 monotonicBaseRef:4000212476 monotonicFrequency:2299804741 realtimeReady:1 realtimeBaseCycles:15559470537597587 realtimeBaseRef:1545145022567981217 realtimeFrequency:2299805036} D1218 14:57:03.567928 10950 x:0] Clock(Monotonic): error: 72 ns, adjusted frequency from 2299804741 Hz to 2299804966 Hz D1218 14:57:03.568055 10950 x:0] Clock(Realtime): error: 210 ns, adjusted frequency from 2299805036 Hz to 2299805278 Hz D1218 14:57:03.568134 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559472837237889 monotonicBaseRef:5000269461 monotonicFrequency:2299804966 realtimeReady:1 realtimeBaseCycles:15559472837559854 realtimeBaseRef:1545145023568049584 realtimeFrequency:2299805278} D1218 14:57:04.570385 10950 x:0] Clock(Monotonic): error: 203 ns, adjusted frequency from 2299804966 Hz to 2299805302 Hz D1218 14:57:04.570533 10950 x:0] Clock(Realtime): error: -63 ns, adjusted frequency from 2299805278 Hz to 2299804658 Hz D1218 14:57:04.570592 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559475142695070 monotonicBaseRef:6002727154 monotonicFrequency:2299805302 realtimeReady:1 realtimeBaseCycles:15559475143067350 realtimeBaseRef:1545145024570529019 realtimeFrequency:2299804658} D1218 14:57:05.568643 10950 x:0] Clock(Monotonic): error: -146 ns, adjusted frequency from 2299805302 Hz to 2299804488 Hz D1218 14:57:05.568747 10950 x:0] Clock(Realtime): error: 30 ns, adjusted frequency from 2299804658 Hz to 2299804885 Hz D1218 14:57:05.568802 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559477438493444 monotonicBaseRef:7000984863 monotonicFrequency:2299804488 realtimeReady:1 realtimeBaseCycles:15559477438766530 realtimeBaseRef:1545145025568743876 realtimeFrequency:2299804885} D1218 14:57:06.567912 10950 x:0] Clock(Monotonic): error: 116 ns, adjusted frequency from 2299804488 Hz to 2299805101 Hz D1218 14:57:06.568045 10950 x:0] Clock(Realtime): error: 120 ns, adjusted frequency from 2299804885 Hz to 2299805109 Hz D1218 14:57:06.568108 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559479736592104 monotonicBaseRef:8000243135 monotonicFrequency:2299805101 realtimeReady:1 realtimeBaseCycles:15559479736948569 realtimeBaseRef:1545145026568038230 realtimeFrequency:2299805109} D1218 14:57:07.567913 10950 x:0] Clock(Monotonic): error: -58 ns, adjusted frequency from 2299805101 Hz to 2299804713 Hz D1218 14:57:07.568053 10950 x:0] Clock(Realtime): error: -100 ns, adjusted frequency from 2299805109 Hz to 2299804608 Hz D1218 14:57:07.568123 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559482036434217 monotonicBaseRef:9000259228 monotonicFrequency:2299804713 realtimeReady:1 realtimeBaseCycles:15559482036779248 realtimeBaseRef:1545145027568049348 realtimeFrequency:2299804608} D1218 14:57:08.567930 10950 x:0] Clock(Monotonic): error: 159 ns, adjusted frequency from 2299804713 Hz to 2299805279 Hz D1218 14:57:08.568079 10950 x:0] Clock(Realtime): error: 30 ns, adjusted frequency from 2299804608 Hz to 2299804980 Hz D1218 14:57:08.568162 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559484336256070 monotonicBaseRef:10000266680 monotonicFrequency:2299805279 realtimeReady:1 realtimeBaseCycles:15559484336609492 realtimeBaseRef:1545145028568060495 realtimeFrequency:2299804980} D1218 14:57:09.567911 10950 x:0] Clock(Monotonic): error: -136 ns, adjusted frequency from 2299805279 Hz to 2299804606 Hz D1218 14:57:09.568043 10950 x:0] Clock(Realtime): error: 40 ns, adjusted frequency from 2299804980 Hz to 2299804988 Hz D1218 14:57:09.568083 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559486636038318 monotonicBaseRef:11000256665 monotonicFrequency:2299804606 realtimeReady:1 realtimeBaseCycles:15559486636364738 realtimeBaseRef:1545145029568038869 realtimeFrequency:2299804988} D1218 14:57:10.567903 10950 x:0] Clock(Monotonic): error: 78 ns, adjusted frequency from 2299804606 Hz to 2299805103 Hz D1218 14:57:10.568014 10950 x:0] Clock(Realtime): error: 119 ns, adjusted frequency from 2299804988 Hz to 2299805188 Hz D1218 14:57:10.568058 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559488935820846 monotonicBaseRef:12000247065 monotonicFrequency:2299805103 realtimeReady:1 realtimeBaseCycles:15559488936102146 realtimeBaseRef:1545145030568009483 realtimeFrequency:2299805188} D1218 14:57:11.568027 10950 x:0] Clock(Monotonic): error: 47 ns, adjusted frequency from 2299805103 Hz to 2299805018 Hz D1218 14:57:11.568136 10950 x:0] Clock(Realtime): error: -142 ns, adjusted frequency from 2299805188 Hz to 2299804585 Hz D1218 14:57:11.568168 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559491235877656 monotonicBaseRef:13000356512 monotonicFrequency:2299805018 realtimeReady:1 realtimeBaseCycles:15559491236188419 realtimeBaseRef:1545145031568131704 realtimeFrequency:2299804585} D1218 14:57:12.567949 10950 x:0] Clock(Monotonic): error: 38 ns, adjusted frequency from 2299805018 Hz to 2299805002 Hz D1218 14:57:12.568127 10950 x:0] Clock(Realtime): error: 189 ns, adjusted frequency from 2299804585 Hz to 2299805343 Hz D1218 14:57:12.568196 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559493535488243 monotonicBaseRef:14000271969 monotonicFrequency:2299805002 realtimeReady:1 realtimeBaseCycles:15559493535970174 realtimeBaseRef:1545145032568121777 realtimeFrequency:2299805343} D1218 14:57:13.567940 10950 x:0] Clock(Monotonic): error: 90 ns, adjusted frequency from 2299805002 Hz to 2299805120 Hz D1218 14:57:13.568057 10950 x:0] Clock(Realtime): error: -124 ns, adjusted frequency from 2299805343 Hz to 2299804595 Hz D1218 14:57:13.568135 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559495835300559 monotonicBaseRef:15000275149 monotonicFrequency:2299805120 realtimeReady:1 realtimeBaseCycles:15559495835613923 realtimeBaseRef:1545145033568051512 realtimeFrequency:2299804595} D1218 14:57:14.567988 10950 x:0] Clock(Monotonic): error: -93 ns, adjusted frequency from 2299805120 Hz to 2299804708 Hz D1218 14:57:14.568116 10950 x:0] Clock(Realtime): error: 112 ns, adjusted frequency from 2299804595 Hz to 2299805162 Hz D1218 14:57:14.568184 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559498135202159 monotonicBaseRef:16000317100 monotonicFrequency:2299804708 realtimeReady:1 realtimeBaseCycles:15559498135552893 realtimeBaseRef:1545145034568109940 realtimeFrequency:2299805162} D1218 14:57:15.567925 10950 x:0] Clock(Monotonic): error: -156 ns, adjusted frequency from 2299804708 Hz to 2299804550 Hz D1218 14:57:15.568041 10950 x:0] Clock(Realtime): error: 42 ns, adjusted frequency from 2299805162 Hz to 2299805007 Hz D1218 14:57:15.568092 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559500434893999 monotonicBaseRef:17000268022 monotonicFrequency:2299804550 realtimeReady:1 realtimeBaseCycles:15559500435184881 realtimeBaseRef:1545145035568034640 realtimeFrequency:2299805007} D1218 14:57:16.567865 10950 x:0] Clock(Monotonic): error: -40 ns, adjusted frequency from 2299804550 Hz to 2299804813 Hz D1218 14:57:16.567989 10950 x:0] Clock(Realtime): error: -193 ns, adjusted frequency from 2299805007 Hz to 2299804470 Hz D1218 14:57:16.568064 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559502734565514 monotonicBaseRef:18000210175 monotonicFrequency:2299804813 realtimeReady:1 realtimeBaseCycles:15559502734874741 realtimeBaseRef:1545145036567984571 realtimeFrequency:2299804470} D1218 14:57:17.567891 10950 x:0] Clock(Monotonic): error: 18 ns, adjusted frequency from 2299804813 Hz to 2299804947 Hz D1218 14:57:17.567998 10950 x:0] Clock(Realtime): error: 219 ns, adjusted frequency from 2299804470 Hz to 2299805423 Hz D1218 14:57:17.568070 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559505034434887 monotonicBaseRef:19000238246 monotonicFrequency:2299804947 realtimeReady:1 realtimeBaseCycles:15559505034678991 realtimeBaseRef:1545145037567984475 realtimeFrequency:2299805423} D1218 14:57:18.568349 10950 x:0] Clock(Monotonic): error: 139 ns, adjusted frequency from 2299804947 Hz to 2299805229 Hz D1218 14:57:18.568468 10950 x:0] Clock(Realtime): error: -32 ns, adjusted frequency from 2299805423 Hz to 2299804851 Hz D1218 14:57:18.568527 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559507335283030 monotonicBaseRef:20000691847 monotonicFrequency:2299805229 realtimeReady:1 realtimeBaseCycles:15559507335584003 realtimeBaseRef:1545145038568462597 realtimeFrequency:2299804851} D1218 14:57:19.567924 10950 x:0] Clock(Monotonic): error: 115 ns, adjusted frequency from 2299805229 Hz to 2299805188 Hz D1218 14:57:19.568035 10950 x:0] Clock(Realtime): error: 9 ns, adjusted frequency from 2299804851 Hz to 2299804934 Hz D1218 14:57:19.568081 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559509634110569 monotonicBaseRef:21000266728 monotonicFrequency:2299805188 realtimeReady:1 realtimeBaseCycles:15559509634394417 realtimeBaseRef:1545145039568030196 realtimeFrequency:2299804934} D1218 14:57:20.567885 10950 x:0] Clock(Monotonic): error: -124 ns, adjusted frequency from 2299805188 Hz to 2299804625 Hz D1218 14:57:20.567992 10950 x:0] Clock(Realtime): error: -147 ns, adjusted frequency from 2299804934 Hz to 2299804575 Hz D1218 14:57:20.568038 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559511933827338 monotonicBaseRef:22000228281 monotonicFrequency:2299804625 realtimeReady:1 realtimeBaseCycles:15559511934097807 realtimeBaseRef:1545145040567986042 realtimeFrequency:2299804575} D1218 14:57:21.567940 10950 x:0] Clock(Monotonic): error: -136 ns, adjusted frequency from 2299804625 Hz to 2299804590 Hz D1218 14:57:21.568048 10950 x:0] Clock(Realtime): error: -27 ns, adjusted frequency from 2299804575 Hz to 2299804843 Hz D1218 14:57:21.568083 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559514233764664 monotonicBaseRef:23000285981 monotonicFrequency:2299804590 realtimeReady:1 realtimeBaseCycles:15559514234034206 realtimeBaseRef:1545145041568043361 realtimeFrequency:2299804843} D1218 14:57:22.567903 10950 x:0] Clock(Monotonic): error: 72 ns, adjusted frequency from 2299804590 Hz to 2299805067 Hz D1218 14:57:22.568042 10950 x:0] Clock(Realtime): error: 49 ns, adjusted frequency from 2299804843 Hz to 2299805062 Hz D1218 14:57:22.568091 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559516533476959 monotonicBaseRef:24000245849 monotonicFrequency:2299805067 realtimeReady:1 realtimeBaseCycles:15559516533823286 realtimeBaseRef:1545145042568036506 realtimeFrequency:2299805062} D1218 14:57:23.567878 10950 x:0] Clock(Monotonic): error: -23 ns, adjusted frequency from 2299805067 Hz to 2299804845 Hz D1218 14:57:23.567985 10950 x:0] Clock(Realtime): error: -33 ns, adjusted frequency from 2299805062 Hz to 2299804847 Hz D1218 14:57:23.568077 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559518833225735 monotonicBaseRef:25000221372 monotonicFrequency:2299804845 realtimeReady:1 realtimeBaseCycles:15559518833496723 realtimeBaseRef:1545145043567979272 realtimeFrequency:2299804847} D1218 14:57:24.567912 10950 x:0] Clock(Monotonic): error: 75 ns, adjusted frequency from 2299804845 Hz to 2299805095 Hz D1218 14:57:24.568032 10950 x:0] Clock(Realtime): error: 80 ns, adjusted frequency from 2299804847 Hz to 2299805090 Hz D1218 14:57:24.568111 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559521133031371 monotonicBaseRef:26000221715 monotonicFrequency:2299805095 realtimeReady:1 realtimeBaseCycles:15559521133406421 realtimeBaseRef:1545145044568024863 realtimeFrequency:2299805090} D1218 14:57:25.567912 10950 x:0] Clock(Monotonic): error: 98 ns, adjusted frequency from 2299805095 Hz to 2299805152 Hz D1218 14:57:25.568031 10950 x:0] Clock(Realtime): error: -36 ns, adjusted frequency from 2299805090 Hz to 2299804824 Hz D1218 14:57:25.568099 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559523432887811 monotonicBaseRef:27000244040 monotonicFrequency:2299805152 realtimeReady:1 realtimeBaseCycles:15559523433209011 realtimeBaseRef:1545145045568023775 realtimeFrequency:2299804824} D1218 14:57:26.567895 10950 x:0] Clock(Monotonic): error: -175 ns, adjusted frequency from 2299805152 Hz to 2299804511 Hz D1218 14:57:26.568008 10950 x:0] Clock(Realtime): error: -53 ns, adjusted frequency from 2299804824 Hz to 2299804779 Hz D1218 14:57:26.568049 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559525732646255 monotonicBaseRef:28000223730 monotonicFrequency:2299804511 realtimeReady:1 realtimeBaseCycles:15559525732952297 realtimeBaseRef:1545145046567997017 realtimeFrequency:2299804779} D1218 14:57:27.567887 10950 x:0] Clock(Monotonic): error: 164 ns, adjusted frequency from 2299804511 Hz to 2299805299 Hz D1218 14:57:27.568019 10950 x:0] Clock(Realtime): error: 82 ns, adjusted frequency from 2299804779 Hz to 2299805088 Hz D1218 14:57:27.568094 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559528032463938 monotonicBaseRef:29000229457 monotonicFrequency:2299805299 realtimeReady:1 realtimeBaseCycles:15559528032794393 realtimeBaseRef:1545145047568013243 realtimeFrequency:2299805088} D1218 14:57:28.567884 10950 x:0] Clock(Monotonic): error: -208 ns, adjusted frequency from 2299805299 Hz to 2299804420 Hz D1218 14:57:28.567977 10950 x:0] Clock(Realtime): error: -105 ns, adjusted frequency from 2299805088 Hz to 2299804669 Hz D1218 14:57:28.568013 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559530332270219 monotonicBaseRef:30000229883 monotonicFrequency:2299804420 realtimeReady:1 realtimeBaseCycles:15559530332508228 realtimeBaseRef:1545145048567973564 realtimeFrequency:2299804669} D1218 14:57:29.567927 10950 x:0] Clock(Monotonic): error: 54 ns, adjusted frequency from 2299804420 Hz to 2299805029 Hz D1218 14:57:29.568043 10950 x:0] Clock(Realtime): error: 30 ns, adjusted frequency from 2299804669 Hz to 2299804981 Hz D1218 14:57:29.568137 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559532632165428 monotonicBaseRef:31000269359 monotonicFrequency:2299805029 realtimeReady:1 realtimeBaseCycles:15559532632461291 realtimeBaseRef:1545145049568038088 realtimeFrequency:2299804981} D1218 14:57:30.567916 10950 x:0] Clock(Monotonic): error: 96 ns, adjusted frequency from 2299805029 Hz to 2299805137 Hz D1218 14:57:30.568029 10950 x:0] Clock(Realtime): error: 104 ns, adjusted frequency from 2299804981 Hz to 2299805158 Hz D1218 14:57:30.568074 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559534931947142 monotonicBaseRef:32000259221 monotonicFrequency:2299805137 realtimeReady:1 realtimeBaseCycles:15559534932232824 realtimeBaseRef:1545145050568023544 realtimeFrequency:2299805158} D1218 14:57:31.567911 10950 x:0] Clock(Monotonic): error: -59 ns, adjusted frequency from 2299805137 Hz to 2299804770 Hz D1218 14:57:31.568068 10950 x:0] Clock(Realtime): error: -101 ns, adjusted frequency from 2299805158 Hz to 2299804670 Hz D1218 14:57:31.568130 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559537231739052 monotonicBaseRef:33000253469 monotonicFrequency:2299804770 realtimeReady:1 realtimeBaseCycles:15559537232125605 realtimeBaseRef:1545145051568061644 realtimeFrequency:2299804670} D1218 14:57:32.567888 10950 x:0] Clock(Monotonic): error: 120 ns, adjusted frequency from 2299804770 Hz to 2299805194 Hz D1218 14:57:32.568043 10950 x:0] Clock(Realtime): error: 133 ns, adjusted frequency from 2299804670 Hz to 2299805223 Hz D1218 14:57:32.568112 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559539531487476 monotonicBaseRef:34000228968 monotonicFrequency:2299805194 realtimeReady:1 realtimeBaseCycles:15559539531872645 realtimeBaseRef:1545145052568036585 realtimeFrequency:2299805223} D1218 14:57:33.567922 10950 x:0] Clock(Monotonic): error: 28 ns, adjusted frequency from 2299805194 Hz to 2299804982 Hz D1218 14:57:33.568074 10950 x:0] Clock(Realtime): error: -65 ns, adjusted frequency from 2299805223 Hz to 2299804770 Hz D1218 14:57:33.568214 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559541831372900 monotonicBaseRef:35000263853 monotonicFrequency:2299804982 realtimeReady:1 realtimeBaseCycles:15559541831748856 realtimeBaseRef:1545145053568067451 realtimeFrequency:2299804770} D1218 14:57:34.567898 10950 x:0] Clock(Monotonic): error: -69 ns, adjusted frequency from 2299804982 Hz to 2299804747 Hz D1218 14:57:34.568014 10950 x:0] Clock(Realtime): error: 49 ns, adjusted frequency from 2299804770 Hz to 2299805030 Hz D1218 14:57:34.568060 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559544131095417 monotonicBaseRef:36000227995 monotonicFrequency:2299804747 realtimeReady:1 realtimeBaseCycles:15559544131417385 realtimeBaseRef:1545145054568008210 realtimeFrequency:2299805030} D1218 14:57:35.567869 10950 x:0] Clock(Monotonic): error: -65 ns, adjusted frequency from 2299804747 Hz to 2299804761 Hz D1218 14:57:35.567985 10950 x:0] Clock(Realtime): error: -38 ns, adjusted frequency from 2299805030 Hz to 2299804834 Hz D1218 14:57:35.568070 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559546430863861 monotonicBaseRef:37000212209 monotonicFrequency:2299804761 realtimeReady:1 realtimeBaseCycles:15559546431157505 realtimeBaseRef:1545145055567979985 realtimeFrequency:2299804834} D1218 14:57:36.567902 10950 x:0] Clock(Monotonic): error: 59 ns, adjusted frequency from 2299804761 Hz to 2299805040 Hz D1218 14:57:36.567998 10950 x:0] Clock(Realtime): error: -154 ns, adjusted frequency from 2299804834 Hz to 2299804555 Hz D1218 14:57:36.568045 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559548730739527 monotonicBaseRef:38000243039 monotonicFrequency:2299805040 realtimeReady:1 realtimeBaseCycles:15559548730994037 realtimeBaseRef:1545145056567993767 realtimeFrequency:2299804555} D1218 14:57:37.567890 10950 x:0] Clock(Monotonic): error: -83 ns, adjusted frequency from 2299805040 Hz to 2299804709 Hz D1218 14:57:37.568051 10950 x:0] Clock(Realtime): error: 83 ns, adjusted frequency from 2299804555 Hz to 2299805105 Hz D1218 14:57:37.568120 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559551030513270 monotonicBaseRef:39000229430 monotonicFrequency:2299804709 realtimeReady:1 realtimeBaseCycles:15559551030914661 realtimeBaseRef:1545145057568044236 realtimeFrequency:2299805105} D1218 14:57:38.567887 10950 x:0] Clock(Monotonic): error: 77 ns, adjusted frequency from 2299804709 Hz to 2299805104 Hz D1218 14:57:38.568002 10950 x:0] Clock(Realtime): error: 79 ns, adjusted frequency from 2299805105 Hz to 2299805090 Hz D1218 14:57:38.568059 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559553330321668 monotonicBaseRef:40000231034 monotonicFrequency:2299805104 realtimeReady:1 realtimeBaseCycles:15559553330607219 realtimeBaseRef:1545145058567995298 realtimeFrequency:2299805090} D1218 14:57:39.567884 10950 x:0] Clock(Monotonic): error: -144 ns, adjusted frequency from 2299805104 Hz to 2299804559 Hz D1218 14:57:39.567985 10950 x:0] Clock(Realtime): error: -151 ns, adjusted frequency from 2299805090 Hz to 2299804554 Hz D1218 14:57:39.568051 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559555630121440 monotonicBaseRef:41000228715 monotonicFrequency:2299804559 realtimeReady:1 realtimeBaseCycles:15559555630378283 realtimeBaseRef:1545145059567980502 realtimeFrequency:2299804554} D1218 14:57:40.567894 10950 x:0] Clock(Monotonic): error: 162 ns, adjusted frequency from 2299804559 Hz to 2299805285 Hz D1218 14:57:40.568012 10950 x:0] Clock(Realtime): error: 154 ns, adjusted frequency from 2299804554 Hz to 2299805268 Hz D1218 14:57:40.568070 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559557929942187 monotonicBaseRef:42000235753 monotonicFrequency:2299805285 realtimeReady:1 realtimeBaseCycles:15559557930245542 realtimeBaseRef:1545145060568007767 realtimeFrequency:2299805268} D1218 14:57:41.568388 10950 x:0] Clock(Monotonic): error: 5 ns, adjusted frequency from 2299805285 Hz to 2299804927 Hz D1218 14:57:41.568514 10950 x:0] Clock(Realtime): error: 40 ns, adjusted frequency from 2299805268 Hz to 2299804997 Hz D1218 14:57:41.568612 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559560230881346 monotonicBaseRef:43000728783 monotonicFrequency:2299804927 realtimeReady:1 realtimeBaseCycles:15559560231199327 realtimeBaseRef:1545145061568507164 realtimeFrequency:2299804997} D1218 14:57:42.568363 10950 x:0] Clock(Monotonic): error: -37 ns, adjusted frequency from 2299804927 Hz to 2299804804 Hz D1218 14:57:42.568474 10950 x:0] Clock(Realtime): error: -61 ns, adjusted frequency from 2299804997 Hz to 2299804767 Hz D1218 14:57:42.568546 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559562530629088 monotonicBaseRef:44000703917 monotonicFrequency:2299804804 realtimeReady:1 realtimeBaseCycles:15559562530918187 realtimeBaseRef:1545145062568469709 realtimeFrequency:2299804767} D1218 14:57:43.567972 10950 x:0] Clock(Monotonic): error: 34 ns, adjusted frequency from 2299804804 Hz to 2299804983 Hz D1218 14:57:43.568089 10950 x:0] Clock(Realtime): error: 31 ns, adjusted frequency from 2299804767 Hz to 2299804985 Hz D1218 14:57:43.568134 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559564829531428 monotonicBaseRef:45000311508 monotonicFrequency:2299804983 realtimeReady:1 realtimeBaseCycles:15559564829833868 realtimeBaseRef:1545145063568083117 realtimeFrequency:2299804985} I1218 14:57:43.622148 10950 x:0] Watchdog starting loop, tasks: 12, discount: 0s D1218 14:57:44.568191 10950 x:0] Clock(Monotonic): error: -30 ns, adjusted frequency from 2299804983 Hz to 2299804838 Hz D1218 14:57:44.568357 10950 x:0] Clock(Realtime): error: -17 ns, adjusted frequency from 2299804985 Hz to 2299804863 Hz D1218 14:57:44.568409 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559567129819467 monotonicBaseRef:46000521550 monotonicFrequency:2299804838 realtimeReady:1 realtimeBaseCycles:15559567130247874 realtimeBaseRef:1545145064568347931 realtimeFrequency:2299804863} D1218 14:57:45.567905 10950 x:0] Clock(Monotonic): error: -123 ns, adjusted frequency from 2299804838 Hz to 2299804622 Hz D1218 14:57:45.568007 10950 x:0] Clock(Realtime): error: -169 ns, adjusted frequency from 2299804863 Hz to 2299804510 Hz D1218 14:57:45.568090 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559569428946859 monotonicBaseRef:47000226983 monotonicFrequency:2299804622 realtimeReady:1 realtimeBaseCycles:15559569429258772 realtimeBaseRef:1545145065568002699 realtimeFrequency:2299804510} D1218 14:57:46.568057 10950 x:0] Clock(Monotonic): error: 45 ns, adjusted frequency from 2299804622 Hz to 2299805023 Hz D1218 14:57:46.568167 10950 x:0] Clock(Realtime): error: 55 ns, adjusted frequency from 2299804510 Hz to 2299805017 Hz D1218 14:57:46.568238 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559571729103301 monotonicBaseRef:48000379961 monotonicFrequency:2299805023 realtimeReady:1 realtimeBaseCycles:15559571729429926 realtimeBaseRef:1545145066568162122 realtimeFrequency:2299805017} D1218 14:57:47.568199 10950 x:0] Clock(Monotonic): error: -50 ns, adjusted frequency from 2299805023 Hz to 2299804785 Hz D1218 14:57:47.568310 10950 x:0] Clock(Realtime): error: -28 ns, adjusted frequency from 2299805017 Hz to 2299804841 Hz D1218 14:57:47.568356 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559574029277711 monotonicBaseRef:49000540577 monotonicFrequency:2299804785 realtimeReady:1 realtimeBaseCycles:15559574029567252 realtimeBaseRef:1545145067568306616 realtimeFrequency:2299804841} D1218 14:57:48.567897 10950 x:0] Clock(Monotonic): error: 159 ns, adjusted frequency from 2299804785 Hz to 2299805294 Hz D1218 14:57:48.568027 10950 x:0] Clock(Realtime): error: 49 ns, adjusted frequency from 2299804841 Hz to 2299804995 Hz D1218 14:57:48.568062 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559576328391079 monotonicBaseRef:50000239935 monotonicFrequency:2299805294 realtimeReady:1 realtimeBaseCycles:15559576328716980 realtimeBaseRef:1545145068568021760 realtimeFrequency:2299804995} D1218 14:57:49.567899 10950 x:0] Clock(Monotonic): error: -32 ns, adjusted frequency from 2299805294 Hz to 2299804839 Hz D1218 14:57:49.568033 10950 x:0] Clock(Realtime): error: 131 ns, adjusted frequency from 2299804995 Hz to 2299805219 Hz D1218 14:57:49.568105 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559578628160836 monotonicBaseRef:51000224482 monotonicFrequency:2299804839 realtimeReady:1 realtimeBaseCycles:15559578628533563 realtimeBaseRef:1545145069568026798 realtimeFrequency:2299805219} D1218 14:57:50.567972 10950 x:0] Clock(Monotonic): error: -124 ns, adjusted frequency from 2299804839 Hz to 2299804616 Hz D1218 14:57:50.568099 10950 x:0] Clock(Realtime): error: -59 ns, adjusted frequency from 2299805219 Hz to 2299804767 Hz D1218 14:57:50.568146 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559580928181376 monotonicBaseRef:52000318273 monotonicFrequency:2299804616 realtimeReady:1 realtimeBaseCycles:15559580928489373 realtimeBaseRef:1545145070568092277 realtimeFrequency:2299804767} D1218 14:57:51.567893 10950 x:0] Clock(Monotonic): error: 120 ns, adjusted frequency from 2299804616 Hz to 2299805183 Hz D1218 14:57:51.568005 10950 x:0] Clock(Realtime): error: 9 ns, adjusted frequency from 2299804767 Hz to 2299804925 Hz D1218 14:57:51.568048 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559583227791297 monotonicBaseRef:53000233615 monotonicFrequency:2299805183 realtimeReady:1 realtimeBaseCycles:15559583228082445 realtimeBaseRef:1545145071568000227 realtimeFrequency:2299804925} D1218 14:57:52.567956 10950 x:0] Clock(Monotonic): error: 21 ns, adjusted frequency from 2299805183 Hz to 2299804962 Hz D1218 14:57:52.568114 10950 x:0] Clock(Realtime): error: 43 ns, adjusted frequency from 2299804925 Hz to 2299805005 Hz D1218 14:57:52.568166 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559585527739862 monotonicBaseRef:54000295960 monotonicFrequency:2299804962 realtimeReady:1 realtimeBaseCycles:15559585528134683 realtimeBaseRef:1545145072568107763 realtimeFrequency:2299805005} D1218 14:57:53.567912 10950 x:0] Clock(Monotonic): error: -117 ns, adjusted frequency from 2299804962 Hz to 2299804640 Hz D1218 14:57:53.568046 10950 x:0] Clock(Realtime): error: 28 ns, adjusted frequency from 2299805005 Hz to 2299804977 Hz D1218 14:57:53.568115 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559587827449001 monotonicBaseRef:55000254294 monotonicFrequency:2299804640 realtimeReady:1 realtimeBaseCycles:15559587827784917 realtimeBaseRef:1545145073568040465 realtimeFrequency:2299804977} D1218 14:57:54.567885 10950 x:0] Clock(Monotonic): error: -17 ns, adjusted frequency from 2299804640 Hz to 2299804870 Hz D1218 14:57:54.567999 10950 x:0] Clock(Realtime): error: -163 ns, adjusted frequency from 2299804977 Hz to 2299804543 Hz D1218 14:57:54.568049 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559590127160111 monotonicBaseRef:56000213625 monotonicFrequency:2299804870 realtimeReady:1 realtimeBaseCycles:15559590127479611 realtimeBaseRef:1545145074567992511 realtimeFrequency:2299804543} D1218 14:57:55.567904 10950 x:0] Clock(Monotonic): error: 203 ns, adjusted frequency from 2299804870 Hz to 2299805389 Hz D1218 14:57:55.568043 10950 x:0] Clock(Realtime): error: 215 ns, adjusted frequency from 2299804543 Hz to 2299805423 Hz D1218 14:57:55.568096 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559592427042147 monotonicBaseRef:57000247178 monotonicFrequency:2299805389 realtimeReady:1 realtimeBaseCycles:15559592427385857 realtimeBaseRef:1545145075568036733 realtimeFrequency:2299805423} D1218 14:57:56.567929 10950 x:0] Clock(Monotonic): error: -85 ns, adjusted frequency from 2299805389 Hz to 2299804714 Hz D1218 14:57:56.568070 10950 x:0] Clock(Realtime): error: -96 ns, adjusted frequency from 2299805423 Hz to 2299804694 Hz D1218 14:57:56.568128 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559594726902100 monotonicBaseRef:58000270903 monotonicFrequency:2299804714 realtimeReady:1 realtimeBaseCycles:15559594727253943 realtimeBaseRef:1545145076568063980 realtimeFrequency:2299804694} D1218 14:57:57.567931 10950 x:0] Clock(Monotonic): error: 21 ns, adjusted frequency from 2299804714 Hz to 2299804956 Hz D1218 14:57:57.568062 10950 x:0] Clock(Realtime): error: 18 ns, adjusted frequency from 2299804694 Hz to 2299804987 Hz D1218 14:57:57.568160 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559597026699205 monotonicBaseRef:59000267594 monotonicFrequency:2299804956 realtimeReady:1 realtimeBaseCycles:15559597027040841 realtimeBaseRef:1545145077568056241 realtimeFrequency:2299804987} D1218 14:57:58.568029 10950 x:0] Clock(Monotonic): error: -113 ns, adjusted frequency from 2299804956 Hz to 2299804644 Hz D1218 14:57:58.568160 10950 x:0] Clock(Realtime): error: -161 ns, adjusted frequency from 2299804987 Hz to 2299804529 Hz D1218 14:57:58.568231 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559599326733125 monotonicBaseRef:60000367152 monotonicFrequency:2299804644 realtimeReady:1 realtimeBaseCycles:15559599327074724 realtimeBaseRef:1545145078568155769 realtimeFrequency:2299804529} D1218 14:57:59.567935 10950 x:0] Clock(Monotonic): error: 105 ns, adjusted frequency from 2299804644 Hz to 2299805156 Hz D1218 14:57:59.568050 10950 x:0] Clock(Realtime): error: 7 ns, adjusted frequency from 2299804529 Hz to 2299804924 Hz D1218 14:57:59.568131 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559601626330840 monotonicBaseRef:61000277175 monotonicFrequency:2299805156 realtimeReady:1 realtimeBaseCycles:15559601626625264 realtimeBaseRef:1545145079568045329 realtimeFrequency:2299804924} D1218 14:58:00.567945 10950 x:0] Clock(Monotonic): error: 12 ns, adjusted frequency from 2299805156 Hz to 2299804949 Hz D1218 14:58:00.568094 10950 x:0] Clock(Realtime): error: 95 ns, adjusted frequency from 2299804924 Hz to 2299805125 Hz D1218 14:58:00.568150 10950 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:15559603926158693 monotonicBaseRef:62000287044 monotonicFrequency:2299804949 realtimeReady:1 realtimeBaseCycles:15559603926527711 realtimeBaseRef:1545145080568087733 realtimeFrequency:2299805125} I1218 14:58:01.323702 17251 x:0] *************************** I1218 14:58:01.323880 17251 x:0] Args: [/syzkaller/managers/ptrace-proxy-sandbox-race/current/image -root /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root -watchdog-action=panic -trace-signal=12 -network=none -debug -platform=ptrace -file-access=shared -network=sandbox 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-1 /syz-executor947974386] I1218 14:58:01.324188 17251 x:0] Git Revision: 12c7430a01ad2b484987dd8ee24b6f2907e7366d I1218 14:58:01.324210 17251 x:0] PID: 17251 I1218 14:58:01.324238 17251 x:0] UID: 0, GID: 0 I1218 14:58:01.324264 17251 x:0] Configuration: I1218 14:58:01.324279 17251 x:0] RootDir: /syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root I1218 14:58:01.324296 17251 x:0] Platform: ptrace I1218 14:58:01.324325 17251 x:0] FileAccess: shared, overlay: false I1218 14:58:01.324352 17251 x:0] Network: sandbox, logging: false I1218 14:58:01.324404 17251 x:0] Strace: false, max size: 1024, syscalls: [] I1218 14:58:01.324442 17251 x:0] *************************** D1218 14:58:01.324819 17251 x:0] Load container "/syzkaller/managers/ptrace-proxy-sandbox-race/workdir/gvisor_root" "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.328217 17251 x:0] Signal container "ci-gvisor-ptrace-proxy-sandbox-race-1": signal 0 D1218 14:58:01.328300 17251 x:0] Signal sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.328336 17251 x:0] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.328824 17251 x:0] urpc: successfully marshalled 117 bytes. D1218 14:58:01.329179 10950 x:0] urpc: unmarshal success. D1218 14:58:01.329466 10950 x:0] containerManager.Signal &{CID:ci-gvisor-ptrace-proxy-sandbox-race-1 Signo:0 PID:0 Mode:Process} D1218 14:58:01.329672 10950 x:0] urpc: successfully marshalled 37 bytes. D1218 14:58:01.329817 17251 x:0] urpc: unmarshal success. D1218 14:58:01.329936 17251 x:0] Execute in container "ci-gvisor-ptrace-proxy-sandbox-race-1", args: /syz-executor947974386 D1218 14:58:01.329993 17251 x:0] Executing new process in container "ci-gvisor-ptrace-proxy-sandbox-race-1" in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.330055 17251 x:0] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.331222 17251 x:0] urpc: successfully marshalled 409 bytes. D1218 14:58:01.331542 10950 x:0] urpc: unmarshal success. D1218 14:58:01.332279 10950 x:0] containerManager.ExecuteAsync: /syz-executor947974386 I1218 14:58:01.332647 10950 x:0] EXEC: [/syz-executor947974386] D1218 14:58:01.333250 10950 x:0] send [FD 6] [Tag 000001] Twalkgetattr{FID: 1, NewFID: 4, Names: [syz-executor947974386]} D1218 14:58:01.334828 10950 x:0] recv [FD 6] [Tag 000001] Rwalkgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, Attr: Attr{Mode: 0o100711, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 844744, BlockSize: 4096, Blocks: 1656, ATime: {Sec: 1545145081, NanoSec: 264485637}, MTime: {Sec: 1545145081, NanoSec: 264485637}, CTime: {Sec: 1545145081, NanoSec: 272486315}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 17694919}]} D1218 14:58:01.335349 10950 x:0] send [FD 6] [Tag 000001] Tgetattr{FID: 4, AttrMask: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime INo Size Blocks BTime Gen DataVersion}} D1218 14:58:01.336241 10950 x:0] recv [FD 6] [Tag 000001] Rgetattr{Valid: AttrMask{with: Mode NLink UID GID RDev ATime MTime CTime Size Blocks}, QID: QID{Type: 0, Version: 0, Path: 17694919}, Attr: Attr{Mode: 0o100711, UID: 0, GID: 0, NLink: 1, RDev: 0, Size: 844744, BlockSize: 4096, Blocks: 1656, ATime: {Sec: 1545145081, NanoSec: 264485637}, MTime: {Sec: 1545145081, NanoSec: 264485637}, CTime: {Sec: 1545145081, NanoSec: 272486315}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}} D1218 14:58:01.336361 10950 x:0] send [FD 6] [Tag 000001] Twalk{FID: 4, NewFID: 5, Names: []} D1218 14:58:01.337110 10950 x:0] recv [FD 6] [Tag 000001] Rwalk{QIDs: [QID{Type: 0, Version: 0, Path: 17694919}]} D1218 14:58:01.337209 10950 x:0] send [FD 6] [Tag 000001] Tlopen{FID: 5, Flags: ReadOnly} D1218 14:58:01.337814 10950 x:0] recv [FD 6] [Tag 000001] Rlopen{QID: QID{Type: 0, Version: 0, Path: 17694919}, IoUnit: 0, File: &{{29}}} D1218 14:58:01.339729 10950 x:0] Allocating stack with size of 8388608 bytes D1218 14:58:01.340947 10950 x:0] updated processes: map[{ci-gvisor-ptrace-proxy-sandbox-race-1 0}:0xc0001297d0 {ci-gvisor-ptrace-proxy-sandbox-race-1 14}:0xc000344660] D1218 14:58:01.341213 10950 x:0] urpc: successfully marshalled 37 bytes. D1218 14:58:01.341365 17251 x:0] urpc: unmarshal success. D1218 14:58:01.341462 17251 x:0] Wait on PID 14 in container "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.341520 17251 x:0] Waiting for PID 14 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.341552 17251 x:0] Connecting to sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.341785 17251 x:0] urpc: successfully marshalled 119 bytes. D1218 14:58:01.342217 10950 x:0] urpc: unmarshal success. D1218 14:58:01.342464 10950 x:0] containerManager.Wait D1218 14:58:01.358454 10950 x:0] [ 14] Interrupt queued D1218 14:58:01.368938 10950 x:0] send [FD 6] [Tag 000001] Twalkgetattr{FID: 1, NewFID: 6, Names: [etc]} D1218 14:58:01.369623 10950 x:0] recv [FD 6] [Tag 000001] Rlerror{Error: 2} executing program panic: invalid allocation length: 0x0 goroutine 107 [running]: gvisor.googlesource.com/gvisor/pkg/sentry/platform/filemem.(*FileMem).Allocate(0xc000151b00, 0x0, 0x1, 0x0, 0x0, 0x0, 0x0) pkg/sentry/platform/filemem/filemem.go:255 +0x78e gvisor.googlesource.com/gvisor/pkg/sentry/platform.AllocateAndFill(0x1203ec0, 0xc000151b00, 0x0, 0x1, 0x11f2440, 0xc00042ef80, 0x0, 0x0, 0x0, 0x0) pkg/sentry/platform/platform.go:418 +0x74 gvisor.googlesource.com/gvisor/pkg/sentry/mm.(*MemoryManager).breakCopyOnWriteLocked(0xc0003fcd80, 0xc0003fd470, 0x4, 0x20002000, 0x21000000, 0x4, 0x21000000, 0x0, 0x0, 0xc0003fd470) pkg/sentry/mm/pma.go:433 +0x342 gvisor.googlesource.com/gvisor/pkg/sentry/mm.(*MemoryManager).getPMAsLocked(0xc0003fcd80, 0x1200780, 0xc00024aa80, 0xc0003fcdf0, 0x5, 0x20002000, 0x21000000, 0x1, 0xc0003fcdf0, 0x7, ...) pkg/sentry/mm/pma.go:142 +0x35a gvisor.googlesource.com/gvisor/pkg/sentry/mm.(*MemoryManager).withInternalMappings(0xc0003fcd80, 0x1200780, 0xc00024aa80, 0x20002640, 0x21000000, 0x100, 0xc0001e4f80, 0xc0001e4fe0, 0x40cbb7, 0xc000350cc0) pkg/sentry/mm/io.go:484 +0x274 gvisor.googlesource.com/gvisor/pkg/sentry/mm.(*MemoryManager).ZeroOut(0xc0003fcd80, 0x1200780, 0xc00024aa80, 0x20002640, 0x7ffff000, 0x450100, 0xc0001e5020, 0xc0001e5020, 0x405bd3) pkg/sentry/mm/io.go:205 +0x1ab gvisor.googlesource.com/gvisor/pkg/sentry/usermem.ZeroOutVec(0x1200780, 0xc00024aa80, 0x11ffa60, 0xc0003fcd80, 0x0, 0x1, 0x20002640, 0x7ffff000, 0x7fffffffffffffff, 0x1200100, ...) pkg/sentry/usermem/usermem.go:324 +0x194 gvisor.googlesource.com/gvisor/pkg/sentry/usermem.IOSequence.ZeroOut(0x11ffa60, 0xc0003fcd80, 0x0, 0x1, 0x20002640, 0x7ffff000, 0x100, 0x1200780, 0xc00024aa80, 0x7fffffffffffffff, ...) pkg/sentry/usermem/usermem.go:514 +0xd5 gvisor.googlesource.com/gvisor/pkg/sentry/fs/dev.(*fullDevice).DeprecatedPreadv(0xc0003467e0, 0x1200780, 0xc00024aa80, 0x11ffa60, 0xc0003fcd80, 0x0, 0x1, 0x20002640, 0x7ffff000, 0x100, ...) pkg/sentry/fs/dev/full.go:49 +0xe1 gvisor.googlesource.com/gvisor/pkg/sentry/fs/fsutil.(*Handle).Read(0xc00042ef40, 0x1200780, 0xc00024aa80, 0xc00026f4d0, 0x11ffa60, 0xc0003fcd80, 0x0, 0x1, 0x20002640, 0x7ffff000, ...) pkg/sentry/fs/fsutil/handle.go:92 +0x107 gvisor.googlesource.com/gvisor/pkg/sentry/fs.(*overlayFileOperations).Read(0xc00045ae40, 0x1200780, 0xc00024aa80, 0xc00026f680, 0x11ffa60, 0xc0003fcd80, 0x0, 0x1, 0x20002640, 0x7ffff000, ...) pkg/sentry/fs/file_overlay.go:223 +0x2c2 gvisor.googlesource.com/gvisor/pkg/sentry/fs.(*File).Preadv(0xc00026f680, 0x1200780, 0xc00024aa80, 0x11ffa60, 0xc0003fcd80, 0x0, 0x1, 0x20002640, 0x7ffff000, 0x100, ...) pkg/sentry/fs/file.go:258 +0x182 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.preadv(0xc00024aa80, 0xc00026f680, 0x11ffa60, 0xc0003fcd80, 0x0, 0x1, 0x20002640, 0x7ffff000, 0x100, 0x0, ...) pkg/sentry/syscalls/linux/sys_read.go:296 +0xee gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Pread64(0xc00024aa80, 0x5, 0x20002640, 0xfffffede, 0x0, 0x0, 0x4002e0, 0x0, 0x0, 0x0, ...) pkg/sentry/syscalls/linux/sys_read.go:114 +0x361 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00024aa80, 0x11, 0x5, 0x20002640, 0xfffffede, 0x0, 0x0, 0x4002e0, 0xc00024aa80, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00024aa80, 0x11, 0x5, 0x20002640, 0xfffffede, 0x0, 0x0, 0x4002e0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00024aa80, 0x11, 0x5, 0x20002640, 0xfffffede, 0x0, 0x0, 0x4002e0, 0xc0001e5c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00024aa80, 0x2, 0xc000532880) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00024aa80, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00024aa80, 0xe) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 1 [semacquire, 1 minutes]: sync.runtime_Semacquire(0xc000148c14) GOROOT/src/runtime/sema.go:56 +0x39 sync.(*WaitGroup).Wait(0xc000148c14) GOROOT/src/sync/waitgroup.go:130 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Kernel).WaitExited(0xc000264780) pkg/sentry/kernel/kernel.go:800 +0x57 gvisor.googlesource.com/gvisor/runsc/boot.(*Loader).WaitExit(0xc000264a00, 0x0, 0x0) runsc/boot/loader.go:757 +0x50 gvisor.googlesource.com/gvisor/runsc/cmd.(*Boot).Execute(0xc000240280, 0x11fb2a0, 0xc000134018, 0xc000138ae0, 0xc0001d7060, 0x2, 0x2, 0x0) runsc/cmd/boot.go:213 +0x133f github.com/google/subcommands.(*Commander).Execute(0xc000144000, 0x11fb2a0, 0xc000134018, 0xc0001d7060, 0x2, 0x2, 0x1) external/com_github_google_subcommands/subcommands.go:141 +0x525 github.com/google/subcommands.Execute(0x11fb2a0, 0xc000134018, 0xc0001d7060, 0x2, 0x2, 0xc000128db0) external/com_github_google_subcommands/subcommands.go:371 +0x81 main.main() runsc/main.go:223 +0x1f5d goroutine 19 [syscall, 1 minutes]: os/signal.signal_recv(0x45b971) GOROOT/src/runtime/sigqueue.go:139 +0x9c os/signal.loop() GOROOT/src/os/signal/signal_unix.go:23 +0x30 created by os/signal.init.0 GOROOT/src/os/signal/signal_unix.go:29 +0x4f goroutine 20 [chan receive, locked to thread]: gvisor.googlesource.com/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0x10e21b0, 0xc00011e240, 0xc00011e2a0) pkg/sentry/platform/ptrace/subprocess.go:162 +0x152 created by gvisor.googlesource.com/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:147 +0x213 goroutine 21 [sync.Cond.Wait]: sync.runtime_notifyListWait(0xc000151f20, 0xc000000001) GOROOT/src/runtime/sema.go:510 +0xeb sync.(*Cond).Wait(0xc000151f10) GOROOT/src/sync/cond.go:56 +0x8e gvisor.googlesource.com/gvisor/pkg/sentry/platform/filemem.(*FileMem).findReclaimable(0xc000151b00, 0x0, 0x0, 0x0) pkg/sentry/platform/filemem/filemem.go:461 +0x99 gvisor.googlesource.com/gvisor/pkg/sentry/platform/filemem.(*FileMem).runReclaim(0xc000151b00) pkg/sentry/platform/filemem/filemem.go:405 +0x78 created by gvisor.googlesource.com/gvisor/pkg/sentry/platform/filemem.newFromFile pkg/sentry/platform/filemem/filemem.go:198 +0x20c goroutine 23 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater.func1(0xc0001395c0, 0xc000148b90) pkg/sentry/kernel/timekeeper.go:215 +0x204 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater pkg/sentry/kernel/timekeeper.go:183 +0xfe goroutine 24 [syscall]: syscall.Syscall(0x7, 0xc0000d86a0, 0x2, 0xffffffffffffffff, 0x0, 0x0, 0x0) bazel-out/k8-fastbuild/bin/external/io_bazel_rules_go/linux_amd64_static_race_stripped/stdlib%/src/syscall/asm_linux_amd64.s:18 +0x5 gvisor.googlesource.com/gvisor/pkg/unet.(*Socket).wait(0xc000288c30, 0xffffffffffffff00, 0x0, 0x0) pkg/unet/unet_unsafe.go:56 +0xb9 gvisor.googlesource.com/gvisor/pkg/unet.(*ServerSocket).Accept(0xc0001360f8, 0x0, 0x0, 0x0) pkg/unet/unet.go:539 +0x150 gvisor.googlesource.com/gvisor/pkg/control/server.(*Server).serve(0xc00028cca0) pkg/control/server/server.go:99 +0x5c gvisor.googlesource.com/gvisor/pkg/control/server.(*Server).StartServing.func1(0xc00028cca0) pkg/control/server/server.go:87 +0x39 created by gvisor.googlesource.com/gvisor/pkg/control/server.(*Server).StartServing pkg/control/server/server.go:86 +0xc9 goroutine 34 [select, 1 minutes]: reflect.rselect(0xc000426000, 0x22, 0x22, 0xc000426000, 0x22) GOROOT/src/runtime/select.go:542 +0x404 reflect.Select(0xc00019f000, 0x22, 0x49, 0x0, 0xfb33c0, 0x22be138, 0x99, 0x0) GOROOT/src/reflect/value.go:2095 +0x223 gvisor.googlesource.com/gvisor/pkg/sentry/sighandling.handleSignals(0xc000314000, 0x21, 0x40, 0xc00026e5a0, 0xc00011e840, 0xc00011e8a0, 0xc00011e900) pkg/sentry/sighandling/sighandling.go:46 +0x4af created by gvisor.googlesource.com/gvisor/pkg/sentry/sighandling.PrepareHandler pkg/sentry/sighandling/sighandling.go:131 +0x2b4 goroutine 26 [syscall, 1 minutes]: syscall.Syscall6(0x119, 0x10, 0xc0002c6ad8, 0x64, 0xffffffffffffffff, 0x0, 0x0, 0xc000148af8, 0xc0002c6a48, 0x47845e) bazel-out/k8-fastbuild/bin/external/io_bazel_rules_go/linux_amd64_static_race_stripped/stdlib%/src/syscall/asm_linux_amd64.s:44 +0x5 gvisor.googlesource.com/gvisor/pkg/fdnotifier.epollWait(0x10, 0xc0002c6ad8, 0x64, 0x64, 0xffffffffffffffff, 0xc0c350, 0xc0002c6c68, 0x20) pkg/fdnotifier/poll_unsafe.go:69 +0x86 gvisor.googlesource.com/gvisor/pkg/fdnotifier.(*notifier).waitAndNotify(0xc00034daa0, 0x0, 0xc000000300) pkg/fdnotifier/fdnotifier.go:146 +0x9e created by gvisor.googlesource.com/gvisor/pkg/fdnotifier.newNotifier pkg/fdnotifier/fdnotifier.go:61 +0x114 goroutine 35 [semacquire, 1 minutes]: sync.runtime_Semacquire(0xc0003fa6c8) GOROOT/src/runtime/sema.go:56 +0x39 sync.(*WaitGroup).Wait(0xc0003fa6c0) GOROOT/src/sync/waitgroup.go:130 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*ThreadGroup).WaitExited(0xc0003fa000) pkg/sentry/kernel/task_run.go:334 +0x41 gvisor.googlesource.com/gvisor/runsc/boot.(*Loader).wait(0xc000264a00, 0xc0003fa000, 0x25) runsc/boot/loader.go:739 +0x39 gvisor.googlesource.com/gvisor/runsc/boot.(*Loader).waitContainer(0xc000264a00, 0xc00046a030, 0x25, 0xc0002cc0b0, 0x0, 0x45d2c2) runsc/boot/loader.go:691 +0x1be gvisor.googlesource.com/gvisor/runsc/boot.(*containerManager).Wait(0xc00028ccc0, 0xc0002ca260, 0xc0002cc0b0, 0x0, 0x0) runsc/boot/controller.go:422 +0xb9 reflect.Value.call(0xc000139bc0, 0xc000136250, 0x13, 0x10b8d3c, 0x4, 0xc0001ade68, 0x3, 0x3, 0x4efe7e, 0xf78e40, ...) GOROOT/src/reflect/value.go:447 +0x62c reflect.Value.Call(0xc000139bc0, 0xc000136250, 0x13, 0xc0001ade68, 0x3, 0x3, 0x0, 0xc00028ccc0, 0x16) GOROOT/src/reflect/value.go:308 +0xc1 gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).handleOne(0xc000288cc0, 0xc00045a090, 0x0, 0x0) pkg/urpc/urpc.go:298 +0x613 gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).handleRegistered(0xc000288cc0, 0xc00045a090, 0xc000288cc0, 0xc00045a090) pkg/urpc/urpc.go:393 +0x43 gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc000288cc0, 0xc00045a090) pkg/urpc/urpc.go:413 +0x77 created by gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).StartHandling pkg/urpc/urpc.go:411 +0x6f goroutine 27 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000252dc0) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 28 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/watchdog.(*Watchdog).loop(0xc000145880) pkg/sentry/watchdog/watchdog.go:181 +0x129 created by gvisor.googlesource.com/gvisor/pkg/sentry/watchdog.(*Watchdog).Start pkg/sentry/watchdog/watchdog.go:155 +0x2ff goroutine 29 [runnable]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000252e60) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 30 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc00026b500, 0xc00011f4a0, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00026b500, 0xc00011f4a0, 0x11f8600, 0x0, 0x301b768, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00026b500, 0x0, 0xc00026b501, 0x301b768, 0x11ec500, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00026b500, 0x301b768, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc000499924, 0xc0004998b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00026b500, 0xca, 0x301b768, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00026b500, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00026b500, 0xca, 0x301b768, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00026b500, 0xca, 0x301b768, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000499c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00026b500, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00026b500, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00026b500, 0x1) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 31 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000252f00) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 32 [chan receive, locked to thread]: gvisor.googlesource.com/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc00040c3f0, 0xc00011f620, 0xc00011f680) pkg/sentry/platform/ptrace/subprocess.go:162 +0x152 created by gvisor.googlesource.com/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:147 +0x213 goroutine 53 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004b6000, 0xc0002aa300, 0xc00011f7a0, 0x0, 0xe93f064eb) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc0004b6000, 0xc0002aa300, 0xc0002ea601, 0x1c8c37b550, 0x0, 0x0) pkg/sentry/kernel/task_block.go:78 +0xd8 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004b6000, 0xc0002aa300, 0x11f8601, 0xdf8475800, 0x301a9b0, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:40 +0x120 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004b6000, 0xdf8475800, 0x0, 0x301a9b0, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004b6000, 0x301a9b0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x486ce3, 0xc0001b1924, 0xc0001b18b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004b6000, 0xca, 0x301a9b0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc0004b6000, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0004b6000, 0xca, 0x301a9b0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0004b6000, 0xca, 0x301a9b0, 0x0, 0x0, 0xc4200d9ea8, 0x0, 0x0, 0xc0001b1c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0004b6000, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0004b6000, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc0004b6000, 0x2) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 33 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000252fa0) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 54 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004b6a80, 0xc0002aa4e0, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004b6a80, 0xc0002aa4e0, 0x11f8600, 0x0, 0xc4200ca548, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004b6a80, 0x0, 0x1, 0xc4200ca548, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004b6a80, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc0001af924, 0xc0001af8b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004b6a80, 0xca, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004b6a80, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0004b6a80, 0xca, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0004b6a80, 0xca, 0xc4200ca548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0001afc00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0004b6a80, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0004b6a80, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc0004b6a80, 0x3) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 37 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004be000) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 55 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004b7500, 0xc0002aa720, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004b7500, 0xc0002aa720, 0x11f8600, 0x0, 0x30392a0, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004b7500, 0x0, 0xc0004b7501, 0x30392a0, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004b7500, 0x30392a0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc00049b924, 0xc00049b8b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004b7500, 0xca, 0x30392a0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004b7500, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0004b7500, 0xca, 0x30392a0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0004b7500, 0xca, 0x30392a0, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00049bc00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0004b7500, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0004b7500, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc0004b7500, 0x4) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 136 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004d4000) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 101 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc00015c000, 0xc00048c2a0, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00015c000, 0xc00048c2a0, 0x11f8600, 0x0, 0xc4200fa148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00015c000, 0x0, 0xc00015c001, 0xc4200fa148, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00015c000, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc0002f3924, 0xc0002f38b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00015c000, 0xca, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00015c000, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00015c000, 0xca, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00015c000, 0xca, 0xc4200fa148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0002f3c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00015c000, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00015c000, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00015c000, 0x5) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 102 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004d40a0) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 147 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc00030a000, 0xc00026c2a0, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00030a000, 0xc00026c2a0, 0x11f8600, 0x0, 0xc4200fa548, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00030a000, 0x0, 0x1, 0xc4200fa548, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00030a000, 0xc4200fa548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc0002ef924, 0xc0002ef8b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00030a000, 0xca, 0xc4200fa548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00030a000, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00030a000, 0xca, 0xc4200fa548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00030a000, 0xca, 0xc4200fa548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0002efc00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00030a000, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00030a000, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00030a000, 0x6) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 163 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0002520a0) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 164 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004ae000, 0xc000520840, 0xc0004ba900, 0x0, 0xe93e9d405) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithDeadline(0xc0004ae000, 0xc000520840, 0xc0002ea401, 0xecf6ec917, 0x0, 0x0) pkg/sentry/kernel/task_block.go:78 +0xd8 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004ae000, 0xc000520840, 0x11f8601, 0x3b850854, 0x301ece0, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:40 +0x120 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004ae000, 0x3b850854, 0x0, 0x301ece0, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004ae000, 0x301ece0, 0x0, 0x0, 0xc4200c2ed8, 0x0, 0x0, 0x486ce3, 0xc0001b9924, 0xc0001b98b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004ae000, 0xca, 0x301ece0, 0x0, 0x0, 0xc4200c2ed8, 0x0, 0x0, 0xc0004ae000, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0004ae000, 0xca, 0x301ece0, 0x0, 0x0, 0xc4200c2ed8, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0004ae000, 0xca, 0x301ece0, 0x0, 0x0, 0xc4200c2ed8, 0x0, 0x0, 0xc0001b9c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0004ae000, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0004ae000, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc0004ae000, 0x7) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 83 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004be640) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 137 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc00024e000) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 151 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc00030b500, 0xc00026d2c0, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00030b500, 0xc00026d2c0, 0x11f8600, 0x0, 0xc4200fa948, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00030b500, 0x0, 0xc00030b501, 0xc4200fa948, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00030b500, 0xc4200fa948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc0001ab924, 0xc0001ab8b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00030b500, 0xca, 0xc4200fa948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00030b500, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00030b500, 0xca, 0xc4200fa948, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00030b500, 0xca, 0xc4200fa948, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0001abc00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00030b500, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00030b500, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00030b500, 0x9) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 84 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc00024a000, 0xc0004bae40, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00024a000, 0xc0004bae40, 0x11f8600, 0x0, 0xc420482148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00024a000, 0x0, 0xc00024a001, 0xc420482148, 0x0, 0xffffffff, 0x1, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00024a000, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc000463924, 0xc0004638b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00024a000, 0xca, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00024a000, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00024a000, 0xca, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00024a000, 0xca, 0xc420482148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000463c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00024a000, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00024a000, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00024a000, 0xa) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 103 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004d4140) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 104 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc00015ca80, 0xc00048cc60, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00015ca80, 0xc00048cc60, 0x11f8600, 0x0, 0xc4200cbd48, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00015ca80, 0x0, 0xc00015ca01, 0xc4200cbd48, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00015ca80, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc000497924, 0xc0004978b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00015ca80, 0xca, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00015ca80, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00015ca80, 0xca, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00015ca80, 0xca, 0xc4200cbd48, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc000497c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00015ca80, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00015ca80, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00015ca80, 0xb) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 80 [select, 1 minutes]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000464000) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 152 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc00030aa80, 0xc00026c300, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc00030aa80, 0xc00026c300, 0x11f8600, 0x0, 0xc4204be148, 0x0, 0xffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc00030aa80, 0x0, 0xc00030aa01, 0xc4204be148, 0x0, 0xffffffff, 0x0, 0x0, 0x0) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc00030aa80, 0xc4204be148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc0002ed924, 0xc0002ed8b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc00030aa80, 0xca, 0xc4204be148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc00030aa80, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc00030aa80, 0xca, 0xc4204be148, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc00030aa80, 0xca, 0xc4204be148, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0002edc00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc00030aa80, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc00030aa80, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc00030aa80, 0xc) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 153 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0002e6140) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 165 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).block(0xc0004aea80, 0xc00011e4e0, 0x0, 0x1, 0x0) pkg/sentry/kernel/task_block.go:124 +0x14d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).BlockWithTimeout(0xc0004aea80, 0xc00011e4e0, 0x11f8600, 0x0, 0xc4204be548, 0x907100, 0xc0ffffffff) pkg/sentry/kernel/task_block.go:35 +0x303 gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.futexWaitDuration(0xc0004aea80, 0x0, 0x7fdbc8030e01, 0xc4204be548, 0x0, 0xffffffff, 0xc000148be8, 0x43b48b, 0x43b505) pkg/sentry/syscalls/linux/sys_futex.go:97 +0x13c gvisor.googlesource.com/gvisor/pkg/sentry/syscalls/linux.Futex(0xc0004aea80, 0xc4204be548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x486ce3, 0xc0001b5924, 0xc0001b58b8, ...) pkg/sentry/syscalls/linux/sys_futex.go:166 +0x131 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).executeSyscall(0xc0004aea80, 0xca, 0xc4204be548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0004aea80, 0x0, ...) pkg/sentry/kernel/task_syscall.go:165 +0x17b gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallInvoke(0xc0004aea80, 0xca, 0xc4204be548, 0x0, 0x0, 0x0, 0x0, 0x0, 0x11f2160, 0x0) pkg/sentry/kernel/task_syscall.go:283 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscallEnter(0xc0004aea80, 0xca, 0xc4204be548, 0x0, 0x0, 0x0, 0x0, 0x0, 0xc0001b5c00, 0x4784ae) pkg/sentry/kernel/task_syscall.go:244 +0x10d gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).doSyscall(0xc0004aea80, 0x2, 0xc00013b780) pkg/sentry/kernel/task_syscall.go:219 +0x1e4 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*runApp).execute(0x0, 0xc0004aea80, 0x11f2160, 0x0) pkg/sentry/kernel/task_run.go:215 +0x15aa gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).run(0xc0004aea80, 0xd) pkg/sentry/kernel/task_run.go:91 +0x24c created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*Task).Start pkg/sentry/kernel/task_start.go:279 +0x19e goroutine 105 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000252320) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 106 [select]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc000252500) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 166 [runnable]: gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).runGoroutine(0xc0004640a0) pkg/sentry/kernel/time/time.go:507 +0x149 created by gvisor.googlesource.com/gvisor/pkg/sentry/kernel/time.(*Timer).init pkg/sentry/kernel/time/time.go:486 +0x227 goroutine 167 [chan receive, locked to thread]: gvisor.googlesource.com/gvisor/pkg/sentry/platform/ptrace.newSubprocess.func1(0xc000306210, 0xc00011fb60, 0xc00011fbc0) pkg/sentry/platform/ptrace/subprocess.go:162 +0x152 created by gvisor.googlesource.com/gvisor/pkg/sentry/platform/ptrace.newSubprocess pkg/sentry/platform/ptrace/subprocess.go:147 +0x213 goroutine 141 [semacquire]: sync.runtime_Semacquire(0xc0003faec8) GOROOT/src/runtime/sema.go:56 +0x39 sync.(*WaitGroup).Wait(0xc0003faec0) GOROOT/src/sync/waitgroup.go:130 +0xb5 gvisor.googlesource.com/gvisor/pkg/sentry/kernel.(*ThreadGroup).WaitExited(0xc0003fa800) pkg/sentry/kernel/task_run.go:334 +0x41 gvisor.googlesource.com/gvisor/runsc/boot.(*Loader).wait(0xc000264a00, 0xc0003fa800, 0x25) runsc/boot/loader.go:739 +0x39 gvisor.googlesource.com/gvisor/runsc/boot.(*Loader).waitPID(0xc000264a00, 0xe, 0xc0004842d0, 0x25, 0x1, 0xc0002cd3ec, 0x28, 0x45d2c2) runsc/boot/loader.go:705 +0x52f gvisor.googlesource.com/gvisor/runsc/boot.(*containerManager).WaitPID(0xc00028ccc0, 0xc000200c00, 0xc0002cd3ec, 0x0, 0x0) runsc/boot/controller.go:443 +0x117 reflect.Value.call(0xc000139c80, 0xc000136278, 0x13, 0x10b8d3c, 0x4, 0xc0001b7e68, 0x3, 0x3, 0x4efe7e, 0xf78e40, ...) GOROOT/src/reflect/value.go:447 +0x62c reflect.Value.Call(0xc000139c80, 0xc000136278, 0x13, 0xc0001b7e68, 0x3, 0x3, 0x0, 0xc00028ccc0, 0x16) GOROOT/src/reflect/value.go:308 +0xc1 gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).handleOne(0xc000288cc0, 0xc00012c7e0, 0x0, 0x0) pkg/urpc/urpc.go:298 +0x613 gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).handleRegistered(0xc000288cc0, 0xc00012c7e0, 0xc000288cc0, 0xc00012c7e0) pkg/urpc/urpc.go:393 +0x43 gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).StartHandling.func1(0xc000288cc0, 0xc00012c7e0) pkg/urpc/urpc.go:413 +0x77 created by gvisor.googlesource.com/gvisor/pkg/urpc.(*Server).StartHandling pkg/urpc/urpc.go:411 +0x6f W1218 14:58:01.568373 17251 x:0] FATAL ERROR: error waiting on pid 14: error waiting on PID 14 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1": urpc method "containerManager.WaitPID" failed: EOF error waiting on pid 14: error waiting on PID 14 in sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1": urpc method "containerManager.WaitPID" failed: EOF W1218 14:58:01.572801 10921 x:0] Wait RPC to container "ci-gvisor-ptrace-proxy-sandbox-race-1" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D1218 14:58:01.573521 10921 x:0] Destroy container "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.573587 10921 x:0] Destroying container "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.573642 10921 x:0] Destroying root container "ci-gvisor-ptrace-proxy-sandbox-race-1" by destroying sandbox D1218 14:58:01.573691 10921 x:0] Destroy sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.573732 10921 x:0] Killing sandbox "ci-gvisor-ptrace-proxy-sandbox-race-1" D1218 14:58:01.574145 10921 x:0] Removing chroot mounts "/tmp/runsc-sandbox-chroot-524659365" D1218 14:58:03.949579 10921 x:0] Killing gofer for container "ci-gvisor-ptrace-proxy-sandbox-race-1", PID: 10936 W1218 14:58:08.950261 10921 x:0] error stopping container: gofer is still running I1218 14:58:08.951017 10921 x:0] Exiting with status: 512