D1213 20:26:57.224682 13568 x:0] Time: Adjusting syscall overhead up to 4000 I1213 20:26:57.224845 13568 x:0] CalibratedClock(Monotonic): ready D1213 20:26:57.224968 13568 x:0] Time: Adjusting syscall overhead up to 4000 I1213 20:26:57.225013 13568 x:0] CalibratedClock(Realtime): ready D1213 20:26:57.225037 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611477390767833 monotonicBaseRef:1000378456 monotonicFrequency:2299798488 realtimeReady:1 realtimeBaseCycles:14611477391167421 realtimeBaseRef:1544732817225010181 realtimeFrequency:2299798569} D1213 20:26:58.224719 13568 x:0] Clock(Monotonic): error: 214 ns, adjusted frequency from 2299798488 Hz to 2299799326 Hz D1213 20:26:58.224824 13568 x:0] Clock(Realtime): error: 296 ns, adjusted frequency from 2299798569 Hz to 2299799635 Hz D1213 20:26:58.224858 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611479690261925 monotonicBaseRef:2000246098 monotonicFrequency:2299799326 realtimeReady:1 realtimeBaseCycles:14611479690529832 realtimeBaseRef:1544732818224820530 realtimeFrequency:2299799635} D1213 20:26:59.224729 13568 x:0] Clock(Monotonic): error: 274 ns, adjusted frequency from 2299799326 Hz to 2299799604 Hz D1213 20:26:59.224883 13568 x:0] Clock(Realtime): error: -44 ns, adjusted frequency from 2299799635 Hz to 2299798827 Hz D1213 20:26:59.224941 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611481990074940 monotonicBaseRef:3000252050 monotonicFrequency:2299799604 realtimeReady:1 realtimeBaseCycles:14611481990465529 realtimeBaseRef:1544732819224879692 realtimeFrequency:2299798827} D1213 20:27:00.224738 13568 x:0] Clock(Monotonic): error: -70 ns, adjusted frequency from 2299799604 Hz to 2299798849 Hz D1213 20:27:00.224879 13568 x:0] Clock(Realtime): error: 176 ns, adjusted frequency from 2299798827 Hz to 2299799432 Hz D1213 20:27:00.224933 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611484289880356 monotonicBaseRef:4000254577 monotonicFrequency:2299798849 realtimeReady:1 realtimeBaseCycles:14611484290255132 realtimeBaseRef:1544732820224875681 realtimeFrequency:2299799432} D1213 20:27:01.224744 13568 x:0] Clock(Monotonic): error: 249 ns, adjusted frequency from 2299798849 Hz to 2299799606 Hz D1213 20:27:01.224853 13568 x:0] Clock(Realtime): error: 154 ns, adjusted frequency from 2299799432 Hz to 2299799418 Hz D1213 20:27:01.224893 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611486589721523 monotonicBaseRef:5000272977 monotonicFrequency:2299799606 realtimeReady:1 realtimeBaseCycles:14611486589983948 realtimeBaseRef:1544732821224844975 realtimeFrequency:2299799418} D1213 20:27:02.224741 13568 x:0] Clock(Monotonic): error: -98 ns, adjusted frequency from 2299799606 Hz to 2299798845 Hz D1213 20:27:02.224832 13568 x:0] Clock(Realtime): error: -133 ns, adjusted frequency from 2299799418 Hz to 2299798746 Hz D1213 20:27:02.224878 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611488889485876 monotonicBaseRef:6000257648 monotonicFrequency:2299798845 realtimeReady:1 realtimeBaseCycles:14611488889744130 realtimeBaseRef:1544732822224827914 realtimeFrequency:2299798746} D1213 20:27:03.224757 13568 x:0] Clock(Monotonic): error: 20 ns, adjusted frequency from 2299798845 Hz to 2299799112 Hz D1213 20:27:03.224863 13568 x:0] Clock(Realtime): error: 73 ns, adjusted frequency from 2299798746 Hz to 2299799250 Hz D1213 20:27:03.224897 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611491189350908 monotonicBaseRef:7000286427 monotonicFrequency:2299799112 realtimeReady:1 realtimeBaseCycles:14611491189615868 realtimeBaseRef:1544732823224859652 realtimeFrequency:2299799250} D1213 20:27:04.224737 13568 x:0] Clock(Monotonic): error: 248 ns, adjusted frequency from 2299799112 Hz to 2299799671 Hz D1213 20:27:04.224858 13568 x:0] Clock(Realtime): error: 174 ns, adjusted frequency from 2299799250 Hz to 2299799500 Hz D1213 20:27:04.224954 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611493489066728 monotonicBaseRef:8000250209 monotonicFrequency:2299799671 realtimeReady:1 realtimeBaseCycles:14611493489399459 realtimeBaseRef:1544732824224852843 realtimeFrequency:2299799500} D1213 20:27:05.224699 13568 x:0] Clock(Monotonic): error: -161 ns, adjusted frequency from 2299799671 Hz to 2299798713 Hz D1213 20:27:05.224799 13568 x:0] Clock(Realtime): error: -120 ns, adjusted frequency from 2299799500 Hz to 2299798821 Hz D1213 20:27:05.224861 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611495788817170 monotonicBaseRef:9000228803 monotonicFrequency:2299798713 realtimeReady:1 realtimeBaseCycles:14611495789068874 realtimeBaseRef:1544732825224796279 realtimeFrequency:2299798821} D1213 20:27:06.224691 13568 x:0] Clock(Monotonic): error: 31 ns, adjusted frequency from 2299798713 Hz to 2299799244 Hz D1213 20:27:06.224803 13568 x:0] Clock(Realtime): error: 0 ns, adjusted frequency from 2299798821 Hz to 2299799163 Hz D1213 20:27:06.224858 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611498088597978 monotonicBaseRef:10000221017 monotonicFrequency:2299799244 realtimeReady:1 realtimeBaseCycles:14611498088876856 realtimeBaseRef:1544732826224800262 realtimeFrequency:2299799163} D1213 20:27:07.224753 13568 x:0] Clock(Monotonic): error: -2 ns, adjusted frequency from 2299799244 Hz to 2299799166 Hz D1213 20:27:07.224873 13568 x:0] Clock(Realtime): error: 5 ns, adjusted frequency from 2299799163 Hz to 2299799154 Hz D1213 20:27:07.224909 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611500388538408 monotonicBaseRef:11000282407 monotonicFrequency:2299799166 realtimeReady:1 realtimeBaseCycles:14611500388835966 realtimeBaseRef:1544732827224869810 realtimeFrequency:2299799154} D1213 20:27:08.224699 13568 x:0] Clock(Monotonic): error: -8 ns, adjusted frequency from 2299799166 Hz to 2299799131 Hz D1213 20:27:08.224801 13568 x:0] Clock(Realtime): error: 15 ns, adjusted frequency from 2299799154 Hz to 2299799207 Hz D1213 20:27:08.224860 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611502688207679 monotonicBaseRef:12000225925 monotonicFrequency:2299799131 realtimeReady:1 realtimeBaseCycles:14611502688469840 realtimeBaseRef:1544732828224797942 realtimeFrequency:2299799207} D1213 20:27:09.224716 13568 x:0] Clock(Monotonic): error: 8 ns, adjusted frequency from 2299799131 Hz to 2299799181 Hz D1213 20:27:09.224818 13568 x:0] Clock(Realtime): error: -3 ns, adjusted frequency from 2299799207 Hz to 2299799149 Hz D1213 20:27:09.224848 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611504988043701 monotonicBaseRef:13000241965 monotonicFrequency:2299799181 realtimeReady:1 realtimeBaseCycles:14611504988307403 realtimeBaseRef:1544732829224814619 realtimeFrequency:2299799149} D1213 20:27:10.224715 13568 x:0] Clock(Monotonic): error: -4 ns, adjusted frequency from 2299799181 Hz to 2299799156 Hz D1213 20:27:10.224816 13568 x:0] Clock(Realtime): error: 139 ns, adjusted frequency from 2299799149 Hz to 2299799452 Hz D1213 20:27:10.224849 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611507287843788 monotonicBaseRef:14000242358 monotonicFrequency:2299799156 realtimeReady:1 realtimeBaseCycles:14611507288101163 realtimeBaseRef:1544732830224812275 realtimeFrequency:2299799452} D1213 20:27:11.224719 13568 x:0] Clock(Monotonic): error: -9 ns, adjusted frequency from 2299799156 Hz to 2299799132 Hz D1213 20:27:11.224810 13568 x:0] Clock(Realtime): error: -118 ns, adjusted frequency from 2299799452 Hz to 2299798898 Hz D1213 20:27:11.224844 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611509587653615 monotonicBaseRef:15000246997 monotonicFrequency:2299799132 realtimeReady:1 realtimeBaseCycles:14611509587887420 realtimeBaseRef:1544732831224806537 realtimeFrequency:2299798898} D1213 20:27:12.224678 13568 x:0] Clock(Monotonic): error: 30 ns, adjusted frequency from 2299799132 Hz to 2299799241 Hz D1213 20:27:12.224828 13568 x:0] Clock(Realtime): error: 96 ns, adjusted frequency from 2299798898 Hz to 2299799354 Hz D1213 20:27:12.224879 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611511887330452 monotonicBaseRef:16000193820 monotonicFrequency:2299799241 realtimeReady:1 realtimeBaseCycles:14611511887725944 realtimeBaseRef:1544732832224823767 realtimeFrequency:2299799354} D1213 20:27:13.224746 13568 x:0] Clock(Monotonic): error: -28 ns, adjusted frequency from 2299799241 Hz to 2299799083 Hz D1213 20:27:13.224853 13568 x:0] Clock(Realtime): error: -88 ns, adjusted frequency from 2299799354 Hz to 2299798951 Hz D1213 20:27:13.224886 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611514187310039 monotonicBaseRef:17000272238 monotonicFrequency:2299799083 realtimeReady:1 realtimeBaseCycles:14611514187585488 realtimeBaseRef:1544732833224849938 realtimeFrequency:2299798951} D1213 20:27:14.224712 13568 x:0] Clock(Monotonic): error: -4 ns, adjusted frequency from 2299799083 Hz to 2299799159 Hz D1213 20:27:14.224829 13568 x:0] Clock(Realtime): error: 5 ns, adjusted frequency from 2299798951 Hz to 2299799175 Hz D1213 20:27:14.224861 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611516487030919 monotonicBaseRef:18000238233 monotonicFrequency:2299799159 realtimeReady:1 realtimeBaseCycles:14611516487329504 realtimeBaseRef:1544732834224826051 realtimeFrequency:2299799175} D1213 20:27:15.224833 13568 x:0] Clock(Monotonic): error: -28 ns, adjusted frequency from 2299799159 Hz to 2299799083 Hz D1213 20:27:15.224995 13568 x:0] Clock(Realtime): error: -2 ns, adjusted frequency from 2299799175 Hz to 2299799157 Hz D1213 20:27:15.225032 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611518787066892 monotonicBaseRef:19000341204 monotonicFrequency:2299799083 realtimeReady:1 realtimeBaseCycles:14611518787509576 realtimeBaseRef:1544732835224991672 realtimeFrequency:2299799157} D1213 20:27:16.224689 13568 x:0] Clock(Monotonic): error: 35 ns, adjusted frequency from 2299799083 Hz to 2299799240 Hz D1213 20:27:16.224786 13568 x:0] Clock(Realtime): error: -21 ns, adjusted frequency from 2299799157 Hz to 2299799112 Hz D1213 20:27:16.224819 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611521086577630 monotonicBaseRef:20000215825 monotonicFrequency:2299799240 realtimeReady:1 realtimeBaseCycles:14611521086827582 realtimeBaseRef:1544732836224782457 realtimeFrequency:2299799112} D1213 20:27:17.224689 13568 x:0] Clock(Monotonic): error: -5 ns, adjusted frequency from 2299799240 Hz to 2299799150 Hz D1213 20:27:17.224804 13568 x:0] Clock(Realtime): error: 114 ns, adjusted frequency from 2299799112 Hz to 2299799395 Hz D1213 20:27:17.224847 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611523386383030 monotonicBaseRef:21000218503 monotonicFrequency:2299799150 realtimeReady:1 realtimeBaseCycles:14611523386664949 realtimeBaseRef:1544732837224799091 realtimeFrequency:2299799395} D1213 20:27:18.224668 13568 x:0] Clock(Monotonic): error: -18 ns, adjusted frequency from 2299799150 Hz to 2299799110 Hz D1213 20:27:18.224764 13568 x:0] Clock(Realtime): error: -92 ns, adjusted frequency from 2299799395 Hz to 2299798949 Hz D1213 20:27:18.224796 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611525686132541 monotonicBaseRef:22000196918 monotonicFrequency:2299799110 realtimeReady:1 realtimeBaseCycles:14611525686375112 realtimeBaseRef:1544732838224760291 realtimeFrequency:2299798949} D1213 20:27:19.224750 13568 x:0] Clock(Monotonic): error: 39 ns, adjusted frequency from 2299799110 Hz to 2299799252 Hz D1213 20:27:19.224845 13568 x:0] Clock(Realtime): error: 7 ns, adjusted frequency from 2299798949 Hz to 2299799195 Hz D1213 20:27:19.224930 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611527986092908 monotonicBaseRef:23000267035 monotonicFrequency:2299799252 realtimeReady:1 realtimeBaseCycles:14611527986361244 realtimeBaseRef:1544732839224841682 realtimeFrequency:2299799195} D1213 20:27:20.224675 13568 x:0] Clock(Monotonic): error: -28 ns, adjusted frequency from 2299799252 Hz to 2299799094 Hz D1213 20:27:20.224804 13568 x:0] Clock(Realtime): error: 3 ns, adjusted frequency from 2299799195 Hz to 2299799159 Hz D1213 20:27:20.224841 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611530285744376 monotonicBaseRef:24000202775 monotonicFrequency:2299799094 realtimeReady:1 realtimeBaseCycles:14611530286065506 realtimeBaseRef:1544732840224800403 realtimeFrequency:2299799159} D1213 20:27:21.224719 13568 x:0] Clock(Monotonic): error: -8 ns, adjusted frequency from 2299799094 Hz to 2299799135 Hz D1213 20:27:21.224821 13568 x:0] Clock(Realtime): error: -12 ns, adjusted frequency from 2299799159 Hz to 2299799159 Hz D1213 20:27:21.224852 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611532585649815 monotonicBaseRef:25000249015 monotonicFrequency:2299799135 realtimeReady:1 realtimeBaseCycles:14611532585896698 realtimeBaseRef:1544732841224814331 realtimeFrequency:2299799159} D1213 20:27:22.224712 13568 x:0] Clock(Monotonic): error: 38 ns, adjusted frequency from 2299799135 Hz to 2299799242 Hz D1213 20:27:22.224831 13568 x:0] Clock(Realtime): error: 91 ns, adjusted frequency from 2299799159 Hz to 2299799352 Hz D1213 20:27:22.224882 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611534885407462 monotonicBaseRef:26000230975 monotonicFrequency:2299799242 realtimeReady:1 realtimeBaseCycles:14611534885720593 realtimeBaseRef:1544732842224825086 realtimeFrequency:2299799352} D1213 20:27:23.224699 13568 x:0] Clock(Monotonic): error: -27 ns, adjusted frequency from 2299799242 Hz to 2299799101 Hz D1213 20:27:23.224809 13568 x:0] Clock(Realtime): error: -102 ns, adjusted frequency from 2299799352 Hz to 2299798912 Hz D1213 20:27:23.224843 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611537185197895 monotonicBaseRef:27000227144 monotonicFrequency:2299799101 realtimeReady:1 realtimeBaseCycles:14611537185475113 realtimeBaseRef:1544732843224805592 realtimeFrequency:2299798912} D1213 20:27:24.224700 13568 x:0] Clock(Monotonic): error: 2 ns, adjusted frequency from 2299799101 Hz to 2299799175 Hz D1213 20:27:24.224819 13568 x:0] Clock(Realtime): error: 107 ns, adjusted frequency from 2299798912 Hz to 2299799376 Hz D1213 20:27:24.224865 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611539484997356 monotonicBaseRef:28000227300 monotonicFrequency:2299799175 realtimeReady:1 realtimeBaseCycles:14611539485296478 realtimeBaseRef:1544732844224815355 realtimeFrequency:2299799376} D1213 20:27:25.224687 13568 x:0] Clock(Monotonic): error: 0 ns, adjusted frequency from 2299799175 Hz to 2299799153 Hz D1213 20:27:25.224789 13568 x:0] Clock(Realtime): error: -92 ns, adjusted frequency from 2299799376 Hz to 2299798933 Hz D1213 20:27:25.224839 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611541784767873 monotonicBaseRef:29000214838 monotonicFrequency:2299799153 realtimeReady:1 realtimeBaseCycles:14611541785028457 realtimeBaseRef:1544732845224786049 realtimeFrequency:2299798933} D1213 20:27:26.224697 13568 x:0] Clock(Monotonic): error: 4 ns, adjusted frequency from 2299799153 Hz to 2299799167 Hz D1213 20:27:26.224782 13568 x:0] Clock(Realtime): error: 11 ns, adjusted frequency from 2299798933 Hz to 2299799214 Hz D1213 20:27:26.224814 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611544084591888 monotonicBaseRef:30000225648 monotonicFrequency:2299799167 realtimeReady:1 realtimeBaseCycles:14611544084809649 realtimeBaseRef:1544732846224778334 realtimeFrequency:2299799214} D1213 20:27:27.224737 13568 x:0] Clock(Monotonic): error: 158 ns, adjusted frequency from 2299799167 Hz to 2299799540 Hz D1213 20:27:27.224885 13568 x:0] Time: Adjusting syscall overhead up to 8000 D1213 20:27:27.224975 13568 x:0] Clock(Realtime): error: 428 ns, adjusted frequency from 2299799214 Hz to 2299800171 Hz D1213 20:27:27.225074 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611546384477346 monotonicBaseRef:31000263169 monotonicFrequency:2299799540 realtimeReady:1 realtimeBaseCycles:14611546385048548 realtimeBaseRef:1544732847224969518 realtimeFrequency:2299800171} D1213 20:27:28.224702 13568 x:0] Clock(Monotonic): error: -171 ns, adjusted frequency from 2299799540 Hz to 2299798762 Hz D1213 20:27:28.224808 13568 x:0] Clock(Realtime): error: -287 ns, adjusted frequency from 2299800171 Hz to 2299798474 Hz D1213 20:27:28.224840 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611548684203389 monotonicBaseRef:32000231210 monotonicFrequency:2299798762 realtimeReady:1 realtimeBaseCycles:14611548684468126 realtimeBaseRef:1544732848224804028 realtimeFrequency:2299798474} D1213 20:27:29.224710 13568 x:0] Clock(Monotonic): error: 20 ns, adjusted frequency from 2299798762 Hz to 2299799202 Hz D1213 20:27:29.224814 13568 x:0] Clock(Realtime): error: 57 ns, adjusted frequency from 2299798474 Hz to 2299799261 Hz D1213 20:27:29.224862 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611550984021300 monotonicBaseRef:33000239536 monotonicFrequency:2299799202 realtimeReady:1 realtimeBaseCycles:14611550984258053 realtimeBaseRef:1544732849224800311 realtimeFrequency:2299799261} D1213 20:27:30.224671 13568 x:0] Clock(Monotonic): error: -5 ns, adjusted frequency from 2299799202 Hz to 2299799146 Hz D1213 20:27:30.224802 13568 x:0] Clock(Realtime): error: -97 ns, adjusted frequency from 2299799261 Hz to 2299798896 Hz D1213 20:27:30.224851 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611553283726314 monotonicBaseRef:34000198581 monotonicFrequency:2299799146 realtimeReady:1 realtimeBaseCycles:14611553284051733 realtimeBaseRef:1544732850224797884 realtimeFrequency:2299798896} D1213 20:27:31.224692 13568 x:0] Clock(Monotonic): error: 12 ns, adjusted frequency from 2299799146 Hz to 2299799195 Hz D1213 20:27:31.224813 13568 x:0] Clock(Realtime): error: 17 ns, adjusted frequency from 2299798896 Hz to 2299799197 Hz D1213 20:27:31.224864 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611555583578906 monotonicBaseRef:35000221820 monotonicFrequency:2299799195 realtimeReady:1 realtimeBaseCycles:14611555583835826 realtimeBaseRef:1544732851224791447 realtimeFrequency:2299799197} D1213 20:27:32.224695 13568 x:0] Clock(Monotonic): error: -6 ns, adjusted frequency from 2299799195 Hz to 2299799150 Hz D1213 20:27:32.224786 13568 x:0] Clock(Realtime): error: 72 ns, adjusted frequency from 2299799197 Hz to 2299799321 Hz D1213 20:27:32.224822 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611557883359043 monotonicBaseRef:36000213533 monotonicFrequency:2299799150 realtimeReady:1 realtimeBaseCycles:14611557883613456 realtimeBaseRef:1544732852224782069 realtimeFrequency:2299799321} D1213 20:27:33.224721 13568 x:0] Clock(Monotonic): error: -16 ns, adjusted frequency from 2299799150 Hz to 2299799127 Hz D1213 20:27:33.224802 13568 x:0] Clock(Realtime): error: -21 ns, adjusted frequency from 2299799321 Hz to 2299799125 Hz D1213 20:27:33.224833 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611560183188620 monotonicBaseRef:37000226763 monotonicFrequency:2299799127 realtimeReady:1 realtimeBaseCycles:14611560183451053 realtimeBaseRef:1544732853224798712 realtimeFrequency:2299799125} D1213 20:27:34.224691 13568 x:0] Clock(Monotonic): error: 18 ns, adjusted frequency from 2299799127 Hz to 2299799199 Hz D1213 20:27:34.224785 13568 x:0] Clock(Realtime): error: 40 ns, adjusted frequency from 2299799125 Hz to 2299799244 Hz D1213 20:27:34.224818 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611562482971402 monotonicBaseRef:38000219655 monotonicFrequency:2299799199 realtimeReady:1 realtimeBaseCycles:14611562483211016 realtimeBaseRef:1544732854224781683 realtimeFrequency:2299799244} D1213 20:27:35.224723 13568 x:0] Clock(Monotonic): error: -42 ns, adjusted frequency from 2299799199 Hz to 2299799074 Hz D1213 20:27:35.224828 13568 x:0] Clock(Realtime): error: -83 ns, adjusted frequency from 2299799244 Hz to 2299798895 Hz D1213 20:27:35.224907 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611564782844354 monotonicBaseRef:39000251724 monotonicFrequency:2299799074 realtimeReady:1 realtimeBaseCycles:14611564783109891 realtimeBaseRef:1544732855224825004 realtimeFrequency:2299798895} D1213 20:27:36.224724 13568 x:0] Clock(Monotonic): error: 7 ns, adjusted frequency from 2299799074 Hz to 2299799162 Hz D1213 20:27:36.224847 13568 x:0] Clock(Realtime): error: 100 ns, adjusted frequency from 2299798895 Hz to 2299799336 Hz D1213 20:27:36.224880 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611567082646113 monotonicBaseRef:40000252891 monotonicFrequency:2299799162 realtimeReady:1 realtimeBaseCycles:14611567082949650 realtimeBaseRef:1544732856224842772 realtimeFrequency:2299799336} D1213 20:27:37.224722 13568 x:0] Clock(Monotonic): error: 14 ns, adjusted frequency from 2299799162 Hz to 2299799185 Hz D1213 20:27:37.224817 13568 x:0] Clock(Realtime): error: 11 ns, adjusted frequency from 2299799336 Hz to 2299799190 Hz D1213 20:27:37.224867 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611569382433216 monotonicBaseRef:41000247647 monotonicFrequency:2299799185 realtimeReady:1 realtimeBaseCycles:14611569382680668 realtimeBaseRef:1544732857224813065 realtimeFrequency:2299799190} D1213 20:27:38.224691 13568 x:0] Clock(Monotonic): error: 6 ns, adjusted frequency from 2299799185 Hz to 2299799174 Hz D1213 20:27:38.224788 13568 x:0] Clock(Realtime): error: -43 ns, adjusted frequency from 2299799190 Hz to 2299799068 Hz D1213 20:27:38.224820 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611571682163475 monotonicBaseRef:42000217676 monotonicFrequency:2299799174 realtimeReady:1 realtimeBaseCycles:14611571682413645 realtimeBaseRef:1544732858224784274 realtimeFrequency:2299799068} D1213 20:27:39.224689 13568 x:0] Clock(Monotonic): error: 36 ns, adjusted frequency from 2299799174 Hz to 2299799239 Hz D1213 20:27:39.224790 13568 x:0] Clock(Realtime): error: 75 ns, adjusted frequency from 2299799068 Hz to 2299799354 Hz D1213 20:27:39.224838 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611573981958919 monotonicBaseRef:43000216054 monotonicFrequency:2299799239 realtimeReady:1 realtimeBaseCycles:14611573982216881 realtimeBaseRef:1544732859224786086 realtimeFrequency:2299799354} D1213 20:27:40.224673 13568 x:0] Clock(Monotonic): error: -48 ns, adjusted frequency from 2299799239 Hz to 2299799047 Hz D1213 20:27:40.224780 13568 x:0] Clock(Realtime): error: -98 ns, adjusted frequency from 2299799354 Hz to 2299798923 Hz D1213 20:27:40.224816 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611576281719491 monotonicBaseRef:44000199240 monotonicFrequency:2299799047 realtimeReady:1 realtimeBaseCycles:14611576281994182 realtimeBaseRef:1544732860224776496 realtimeFrequency:2299798923} D1213 20:27:41.224677 13568 x:0] Clock(Monotonic): error: 144 ns, adjusted frequency from 2299799047 Hz to 2299799493 Hz D1213 20:27:41.224791 13568 x:0] Clock(Realtime): error: 44 ns, adjusted frequency from 2299798923 Hz to 2299799267 Hz D1213 20:27:41.224840 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611578581526637 monotonicBaseRef:45000202761 monotonicFrequency:2299799493 realtimeReady:1 realtimeBaseCycles:14611578581816532 realtimeBaseRef:1544732861224786682 realtimeFrequency:2299799267} I1213 20:27:41.274781 13568 x:0] Watchdog starting loop, tasks: 13, discount: 0s D1213 20:27:42.224698 13568 x:0] Clock(Monotonic): error: -156 ns, adjusted frequency from 2299799493 Hz to 2299798802 Hz D1213 20:27:42.224792 13568 x:0] Clock(Realtime): error: -16 ns, adjusted frequency from 2299799267 Hz to 2299799115 Hz D1213 20:27:42.224853 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611580881350185 monotonicBaseRef:46000213220 monotonicFrequency:2299798802 realtimeReady:1 realtimeBaseCycles:14611580881618261 realtimeBaseRef:1544732862224787752 realtimeFrequency:2299799115} D1213 20:27:43.224706 13568 x:0] Clock(Monotonic): error: 74 ns, adjusted frequency from 2299798802 Hz to 2299799337 Hz D1213 20:27:43.224807 13568 x:0] Clock(Realtime): error: 24 ns, adjusted frequency from 2299799115 Hz to 2299799205 Hz D1213 20:27:43.224840 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611583181191556 monotonicBaseRef:47000231729 monotonicFrequency:2299799337 realtimeReady:1 realtimeBaseCycles:14611583181451944 realtimeBaseRef:1544732863224802782 realtimeFrequency:2299799205} D1213 20:27:44.224668 13568 x:0] Clock(Monotonic): error: -47 ns, adjusted frequency from 2299799337 Hz to 2299799051 Hz D1213 20:27:44.224762 13568 x:0] Clock(Realtime): error: 5 ns, adjusted frequency from 2299799205 Hz to 2299799211 Hz D1213 20:27:44.224794 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611585480908653 monotonicBaseRef:48000195969 monotonicFrequency:2299799051 realtimeReady:1 realtimeBaseCycles:14611585481149686 realtimeBaseRef:1544732864224758663 realtimeFrequency:2299799211} D1213 20:27:45.224753 13568 x:0] Clock(Monotonic): error: -25 ns, adjusted frequency from 2299799051 Hz to 2299799107 Hz D1213 20:27:45.224861 13568 x:0] Clock(Realtime): error: -52 ns, adjusted frequency from 2299799211 Hz to 2299799047 Hz D1213 20:27:45.224894 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611587780906627 monotonicBaseRef:49000282464 monotonicFrequency:2299799107 realtimeReady:1 realtimeBaseCycles:14611587781177484 realtimeBaseRef:1544732865224858057 realtimeFrequency:2299799047} D1213 20:27:46.224709 13568 x:0] Clock(Monotonic): error: 25 ns, adjusted frequency from 2299799107 Hz to 2299799227 Hz D1213 20:27:46.224823 13568 x:0] Clock(Realtime): error: 20 ns, adjusted frequency from 2299799047 Hz to 2299799201 Hz D1213 20:27:46.224855 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611590080598150 monotonicBaseRef:50000235684 monotonicFrequency:2299799227 realtimeReady:1 realtimeBaseCycles:14611590080885922 realtimeBaseRef:1544732866224818658 realtimeFrequency:2299799201} D1213 20:27:47.224724 13568 x:0] Clock(Monotonic): error: -19 ns, adjusted frequency from 2299799227 Hz to 2299799127 Hz D1213 20:27:47.224850 13568 x:0] Clock(Realtime): error: 71 ns, adjusted frequency from 2299799201 Hz to 2299799343 Hz D1213 20:27:47.224891 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611592380436651 monotonicBaseRef:51000252761 monotonicFrequency:2299799127 realtimeReady:1 realtimeBaseCycles:14611592380748315 realtimeBaseRef:1544732867224846135 realtimeFrequency:2299799343} D1213 20:27:48.224799 13568 x:0] Clock(Monotonic): error: -10 ns, adjusted frequency from 2299799127 Hz to 2299799139 Hz D1213 20:27:48.224900 13568 x:0] Clock(Realtime): error: -76 ns, adjusted frequency from 2299799343 Hz to 2299798965 Hz D1213 20:27:48.224975 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611594680403796 monotonicBaseRef:52000325818 monotonicFrequency:2299799139 realtimeReady:1 realtimeBaseCycles:14611594680664230 realtimeBaseRef:1544732868224896822 realtimeFrequency:2299798965} D1213 20:27:49.224666 13568 x:0] Clock(Monotonic): error: 12 ns, adjusted frequency from 2299799139 Hz to 2299799190 Hz D1213 20:27:49.224767 13568 x:0] Clock(Realtime): error: 8 ns, adjusted frequency from 2299798965 Hz to 2299799197 Hz D1213 20:27:49.224799 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611596979897991 monotonicBaseRef:53000193222 monotonicFrequency:2299799190 realtimeReady:1 realtimeBaseCycles:14611596980155277 realtimeBaseRef:1544732869224762932 realtimeFrequency:2299799197} D1213 20:27:50.224749 13568 x:0] Clock(Monotonic): error: 8 ns, adjusted frequency from 2299799190 Hz to 2299799161 Hz D1213 20:27:50.224849 13568 x:0] Clock(Realtime): error: -31 ns, adjusted frequency from 2299799197 Hz to 2299799056 Hz D1213 20:27:50.224901 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611599279886088 monotonicBaseRef:54000275362 monotonicFrequency:2299799161 realtimeReady:1 realtimeBaseCycles:14611599280144772 realtimeBaseRef:1544732870224845677 realtimeFrequency:2299799056} D1213 20:27:51.224695 13568 x:0] Clock(Monotonic): error: 5 ns, adjusted frequency from 2299799161 Hz to 2299799167 Hz D1213 20:27:51.224795 13568 x:0] Clock(Realtime): error: 69 ns, adjusted frequency from 2299799056 Hz to 2299799319 Hz D1213 20:27:51.224828 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611601579564288 monotonicBaseRef:55000222765 monotonicFrequency:2299799167 realtimeReady:1 realtimeBaseCycles:14611601579821378 realtimeBaseRef:1544732871224792433 realtimeFrequency:2299799319} D1213 20:27:52.224760 13568 x:0] Clock(Monotonic): error: -10 ns, adjusted frequency from 2299799167 Hz to 2299799136 Hz D1213 20:27:52.224892 13568 x:0] Clock(Realtime): error: -1 ns, adjusted frequency from 2299799319 Hz to 2299799165 Hz D1213 20:27:52.224938 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611603879502030 monotonicBaseRef:56000283020 monotonicFrequency:2299799136 realtimeReady:1 realtimeBaseCycles:14611603879839965 realtimeBaseRef:1544732872224887775 realtimeFrequency:2299799165} I1213 20:27:52.538833 18506 x:0] *************************** I1213 20:27:52.538925 18506 x:0] Args: [/syzkaller/managers/kvm-direct-overlay-host-race/current/image -root /syzkaller/managers/kvm-direct-overlay-host-race/workdir/gvisor_root -watchdog-action=panic -trace-signal=12 -network=none -debug -platform=ptrace -file-access=exclusive -overlay -network=host 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-kvm-direct-overlay-host-race-3 /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=4 -repeat=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller599376565] I1213 20:27:52.539097 18506 x:0] Git Revision: f484b6d4c2f1dea6169ed50a5d3d1809e8f007be I1213 20:27:52.539125 18506 x:0] PID: 18506 I1213 20:27:52.539152 18506 x:0] UID: 0, GID: 0 I1213 20:27:52.539177 18506 x:0] Configuration: I1213 20:27:52.539190 18506 x:0] RootDir: /syzkaller/managers/kvm-direct-overlay-host-race/workdir/gvisor_root I1213 20:27:52.539202 18506 x:0] Platform: ptrace I1213 20:27:52.539220 18506 x:0] FileAccess: exclusive, overlay: true I1213 20:27:52.539238 18506 x:0] Network: host, logging: false I1213 20:27:52.539262 18506 x:0] Strace: false, max size: 1024, syscalls: [] I1213 20:27:52.539278 18506 x:0] *************************** D1213 20:27:52.539506 18506 x:0] Load container "/syzkaller/managers/kvm-direct-overlay-host-race/workdir/gvisor_root" "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.541574 18506 x:0] Signal container "ci-gvisor-kvm-direct-overlay-host-race-3": signal 0 D1213 20:27:52.541631 18506 x:0] Signal sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.541657 18506 x:0] Connecting to sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.541951 18506 x:0] urpc: successfully marshalled 120 bytes. D1213 20:27:52.542444 13568 x:0] urpc: unmarshal success. D1213 20:27:52.542699 13568 x:0] containerManager.Signal &{CID:ci-gvisor-kvm-direct-overlay-host-race-3 Signo:0 PID:0 Mode:Process} D1213 20:27:52.542911 13568 x:0] urpc: successfully marshalled 37 bytes. D1213 20:27:52.543012 18506 x:0] urpc: unmarshal success. D1213 20:27:52.543100 18506 x:0] Execute in container "ci-gvisor-kvm-direct-overlay-host-race-3", args: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=4 -repeat=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller599376565 D1213 20:27:52.543159 18506 x:0] Executing new process in container "ci-gvisor-kvm-direct-overlay-host-race-3" in sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.543224 18506 x:0] Connecting to sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.544054 18506 x:0] urpc: successfully marshalled 581 bytes. D1213 20:27:52.544284 13568 x:0] urpc: unmarshal success. D1213 20:27:52.544855 13568 x:0] containerManager.ExecuteAsync: /syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=4 -repeat=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller599376565 I1213 20:27:52.545239 13568 x:0] EXEC: [/syz-execprog -executor=/syz-executor -arch=amd64 -sandbox=none -procs=4 -repeat=0 -threaded=true -collide=true -cover=0 -fault_call=-1 -fault_nth=-1 /syzkaller599376565] D1213 20:27:52.545773 13568 x:0] send [FD 6] [Tag 000001] Twalkgetattr{FID: 1, NewFID: 4, Names: [syz-execprog]} D1213 20:27:52.546965 13568 x:0] recv [FD 6] [Tag 000001] 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: 14549984, BlockSize: 4096, Blocks: 28424, ATime: {Sec: 1544716303, NanoSec: 427860419}, MTime: {Sec: 1544716303, NanoSec: 427860419}, CTime: {Sec: 1544732816, NanoSec: 717674271}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 8914264}]} D1213 20:27:52.547267 13568 x:0] send [FD 6] [Tag 000001] Twalk{FID: 4, NewFID: 5, Names: []} D1213 20:27:52.547790 13568 x:0] recv [FD 6] [Tag 000001] Rwalk{QIDs: [QID{Type: 0, Version: 0, Path: 8914264}]} D1213 20:27:52.547860 13568 x:0] send [FD 6] [Tag 000001] Tlopen{FID: 5, Flags: ReadOnly} D1213 20:27:52.548421 13568 x:0] recv [FD 6] [Tag 000001] Rlopen{QID: QID{Type: 0, Version: 0, Path: 8914264}, IoUnit: 0, File: &{{29}}} D1213 20:27:52.554518 13568 x:0] Allocating stack with size of 8388608 bytes D1213 20:27:52.555440 13568 x:0] updated processes: map[{ci-gvisor-kvm-direct-overlay-host-race-3 0}:0xc00012f780 {ci-gvisor-kvm-direct-overlay-host-race-3 15}:0xc000306b90] D1213 20:27:52.555757 13568 x:0] urpc: successfully marshalled 37 bytes. D1213 20:27:52.555854 18506 x:0] urpc: unmarshal success. D1213 20:27:52.555940 18506 x:0] Wait on PID 15 in container "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.555992 18506 x:0] Waiting for PID 15 in sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.556017 18506 x:0] Connecting to sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:52.556205 18506 x:0] urpc: successfully marshalled 122 bytes. D1213 20:27:52.556589 13568 x:0] urpc: unmarshal success. D1213 20:27:52.556764 13568 x:0] containerManager.Wait D1213 20:27:52.557842 13568 x:0] [ 15] Interrupt queued D1213 20:27:52.587350 13568 x:0] [ 16] Interrupt queued D1213 20:27:52.588085 13568 x:0] [ 17] Interrupt queued D1213 20:27:52.590211 13568 x:0] [ 18] Interrupt queued D1213 20:27:52.593085 13568 x:0] [ 19] Interrupt queued D1213 20:27:52.597992 13568 x:0] [ 20] Interrupt queued D1213 20:27:52.600955 13568 x:0] [ 21] Interrupt queued D1213 20:27:52.605107 13568 x:0] [ 22] Interrupt queued D1213 20:27:52.644514 13568 x:0] [ 23] Interrupt queued D1213 20:27:52.663372 13568 x:0] [ 24] Interrupt queued D1213 20:27:52.669474 13568 x:0] [ 25] Interrupt queued D1213 20:27:52.685626 13568 x:0] [ 26] Interrupt queued D1213 20:27:52.690007 13568 x:0] [ 27] Interrupt queued D1213 20:27:52.704840 13568 x:0] [ 28] Interrupt queued D1213 20:27:52.709548 13568 x:0] [ 29] Interrupt queued D1213 20:27:52.722633 13568 x:0] [ 30] Interrupt queued D1213 20:27:52.727860 13568 x:0] [ 31] Interrupt queued D1213 20:27:52.742240 13568 x:0] [ 32] Interrupt queued D1213 20:27:52.748631 13568 x:0] [ 33] Interrupt queued D1213 20:27:52.761918 13568 x:0] [ 34] Interrupt queued D1213 20:27:52.767402 13568 x:0] [ 35] Interrupt queued D1213 20:27:52.781386 13568 x:0] [ 36] Interrupt queued D1213 20:27:52.787010 13568 x:0] [ 37] Interrupt queued D1213 20:27:52.800841 13568 x:0] [ 38] Interrupt queued D1213 20:27:52.807368 13568 x:0] [ 39] Interrupt queued D1213 20:27:52.820798 13568 x:0] [ 40] Interrupt queued D1213 20:27:52.827010 13568 x:0] [ 41] Interrupt queued D1213 20:27:52.827936 13568 x:0] [ 42] Interrupt queued D1213 20:27:52.842667 13568 x:0] [ 43] Interrupt queued D1213 20:27:52.849661 13568 x:0] [ 44] Interrupt queued D1213 20:27:52.862620 13568 x:0] [ 45] Interrupt queued D1213 20:27:52.871711 13568 x:0] [ 46] Interrupt queued D1213 20:27:52.885143 13568 x:0] [ 47] Interrupt queued D1213 20:27:52.893153 13568 x:0] [ 48] Interrupt queued D1213 20:27:52.906455 13568 x:0] [ 49] Interrupt queued D1213 20:27:52.914739 13568 x:0] [ 50] Interrupt queued D1213 20:27:52.936585 13568 x:0] [ 51] Interrupt queued D1213 20:27:52.959059 13568 x:0] [ 52] Interrupt queued D1213 20:27:52.980461 13568 x:0] [ 53] Interrupt queued D1213 20:27:53.002378 13568 x:0] [ 54] Interrupt queued D1213 20:27:53.024877 13568 x:0] [ 55] Interrupt queued D1213 20:27:53.045062 13568 x:0] [ 56] Interrupt queued D1213 20:27:53.066202 13568 x:0] [ 57] Interrupt queued D1213 20:27:53.087223 13568 x:0] [ 58] Interrupt queued D1213 20:27:53.107678 13568 x:0] [ 59] Interrupt queued D1213 20:27:53.128480 13568 x:0] [ 60] Interrupt queued D1213 20:27:53.150239 13568 x:0] [ 61] Interrupt queued D1213 20:27:53.171701 13568 x:0] [ 62] Interrupt queued D1213 20:27:53.192439 13568 x:0] [ 63] Interrupt queued D1213 20:27:53.213860 13568 x:0] [ 64] Interrupt queued D1213 20:27:53.224675 13568 x:0] Clock(Monotonic): error: 57 ns, adjusted frequency from 2299799136 Hz to 2299799287 Hz D1213 20:27:53.224837 13568 x:0] Clock(Realtime): error: 60 ns, adjusted frequency from 2299799165 Hz to 2299799308 Hz D1213 20:27:53.224874 13568 x:0] Updating VDSO parameters: {monotonicReady:1 monotonicBaseCycles:14611606179116595 monotonicBaseRef:57000202764 monotonicFrequency:2299799287 realtimeReady:1 realtimeBaseCycles:14611606179514244 realtimeBaseRef:1544732873224833471 realtimeFrequency:2299799308} D1213 20:27:53.232733 13568 x:0] [ 65] Interrupt queued D1213 20:27:53.252986 13568 x:0] [ 66] Interrupt queued D1213 20:27:53.272306 13568 x:0] [ 67] Interrupt queued D1213 20:27:53.293996 13568 x:0] [ 68] Interrupt queued D1213 20:27:53.318081 13568 x:0] [ 69] Interrupt queued D1213 20:27:53.337664 13568 x:0] [ 70] Interrupt queued D1213 20:27:53.345730 13568 x:0] send [FD 6] [Tag 000001] Twalkgetattr{FID: 1, NewFID: 6, Names: [syzkaller599376565]} D1213 20:27:53.346715 13568 x:0] recv [FD 6] [Tag 000001] 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: 230, BlockSize: 4096, Blocks: 8, ATime: {Sec: 1544732872, NanoSec: 514546526}, MTime: {Sec: 1544732872, NanoSec: 514546526}, CTime: {Sec: 1544732872, NanoSec: 514546526}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 8914094}]} D1213 20:27:53.347081 13568 x:0] send [FD 6] [Tag 000001] Twalk{FID: 6, NewFID: 7, Names: []} D1213 20:27:53.347573 13568 x:0] recv [FD 6] [Tag 000001] Rwalk{QIDs: [QID{Type: 0, Version: 0, Path: 8914094}]} D1213 20:27:53.347639 13568 x:0] send [FD 6] [Tag 000001] Tlopen{FID: 7, Flags: ReadOnly} D1213 20:27:53.348087 13568 x:0] recv [FD 6] [Tag 000001] Rlopen{QID: QID{Type: 0, Version: 0, Path: 8914094}, IoUnit: 0, File: &{{23}}} D1213 20:27:53.350657 13568 x:0] send [FD 6] [Tag 000001] Twalkgetattr{FID: 1, NewFID: 8, Names: [etc]} D1213 20:27:53.350980 13568 x:0] recv [FD 6] [Tag 000001] Rlerror{Error: 2} 2018/12/13 20:27:53 parsed 1 programs D1213 20:27:53.356765 13568 x:0] [ 71] Interrupt queued D1213 20:27:53.361162 13568 x:0] send [FD 6] [Tag 000001] Twalkgetattr{FID: 1, NewFID: 8, Names: [syz-executor]} D1213 20:27:53.361865 13568 x:0] send [FD 6] [Tag 000002] Twalkgetattr{FID: 1, NewFID: 9, Names: [syz-executor]} D1213 20:27:53.361945 13568 x:0] recv [FD 6] [Tag 000001] 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: 1503176, BlockSize: 4096, Blocks: 2936, ATime: {Sec: 1544716303, NanoSec: 883900232}, MTime: {Sec: 1544716303, NanoSec: 883900232}, CTime: {Sec: 1544732816, NanoSec: 721674620}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 8914272}]} 2018/12/13 20:27:53 executed programs: 0 D1213 20:27:53.362587 13568 x:0] recv [FD 6] [Tag 000002] 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: 1503176, BlockSize: 4096, Blocks: 2936, ATime: {Sec: 1544716303, NanoSec: 883900232}, MTime: {Sec: 1544716303, NanoSec: 883900232}, CTime: {Sec: 1544732816, NanoSec: 721674620}, BTime: {Sec: 0, NanoSec: 0}, Gen: 0, DataVersion: 0}, QIDs: [QID{Type: 0, Version: 0, Path: 8914272}]} D1213 20:27:53.363494 13568 x:0] send [FD 6] [Tag 000002] Tclunk{FID: 9} D1213 20:27:53.363964 13568 x:0] recv [FD 6] [Tag 000002] Rclunk{} D1213 20:27:53.379023 13568 x:0] [ 37] Entering internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.379577 13568 x:0] [ 72] Interrupt queued D1213 20:27:53.385837 13568 x:0] send [FD 6] [Tag 000002] Twalk{FID: 8, NewFID: 9, Names: []} D1213 20:27:53.386390 13568 x:0] recv [FD 6] [Tag 000002] Rwalk{QIDs: [QID{Type: 0, Version: 0, Path: 8914272}]} D1213 20:27:53.386492 13568 x:0] send [FD 6] [Tag 000002] Tlopen{FID: 9, Flags: ReadOnly} D1213 20:27:53.386936 13568 x:0] recv [FD 6] [Tag 000002] Rlopen{QID: QID{Type: 0, Version: 0, Path: 8914272}, IoUnit: 0, File: &{{24}}} D1213 20:27:53.388790 13568 x:0] [ 72] Allocating stack with size of 8388608 bytes D1213 20:27:53.389745 13568 x:0] [ 37] Leaving internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.397198 13568 x:0] [ 73] Interrupt queued D1213 20:27:53.399519 13568 x:0] [ 68] Entering internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.399964 13568 x:0] [ 74] Interrupt queued D1213 20:27:53.405674 13568 x:0] [ 75] Interrupt queued D1213 20:27:53.408731 13568 x:0] send [FD 6] [Tag 000002] Twalkgetattr{FID: 1, NewFID: 10, Names: [syzcgroup]} D1213 20:27:53.409278 13568 x:0] recv [FD 6] [Tag 000002] Rlerror{Error: 2} D1213 20:27:53.412541 13568 x:0] [ 74] Allocating stack with size of 8388608 bytes D1213 20:27:53.413713 13568 x:0] [ 68] Leaving internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.416142 13568 x:0] [ 28] Entering internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.416649 13568 x:0] [ 76] Interrupt queued D1213 20:27:53.426455 13568 x:0] [ 76] Allocating stack with size of 8388608 bytes D1213 20:27:53.427473 13568 x:0] [ 28] Leaving internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.429247 13568 x:0] [ 77] Interrupt queued D1213 20:27:53.430968 13568 x:0] [ 66] Entering internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.431604 13568 x:0] [ 78] Interrupt queued D1213 20:27:53.434045 13568 x:0] [ 79] Interrupt queued D1213 20:27:53.440815 13568 x:0] [ 80] Interrupt queued D1213 20:27:53.446956 13568 x:0] [ 78] Allocating stack with size of 8388608 bytes D1213 20:27:53.447666 13568 x:0] [ 81] Interrupt queued D1213 20:27:53.447947 13568 x:0] [ 66] Leaving internal stop (*kernel.vforkStop)(nil) D1213 20:27:53.455085 13568 x:0] [ 82] Interrupt queued D1213 20:27:53.465413 13568 x:0] [ 83] Interrupt queued D1213 20:27:53.467498 13568 x:0] [ 84] Interrupt queued D1213 20:27:53.467830 13568 x:0] [ 85] Interrupt queued D1213 20:27:53.485369 13568 x:0] [ 86] Interrupt queued D1213 20:27:53.493081 13568 x:0] [ 87] Interrupt queued D1213 20:27:53.496633 13568 x:0] [ 88] Interrupt queued D1213 20:27:53.508982 13568 x:0] [ 89] Interrupt queued D1213 20:27:53.520417 13568 x:0] [ 90] Interrupt queued D1213 20:27:53.536510 13568 x:0] [ 91] Interrupt queued D1213 20:27:53.561509 13568 x:0] [ 92] Interrupt queued I1213 20:27:53.564192 13568 x:0] Unsupported syscall: ioctl, regs: rax:18446744073709551578 rbx:7454624 rcx:4552345 rdx:536871872 rsi:21522 rdi:4 rsp:47574996376712 rbp:3 r11:582 r12:47574996379348 r13:4882815 r14:7232792 r15:4294967295 rip:4552345 rflags:582 orig_rax:16 cs:51 ss:43 fs_base:47574996379392 W1213 20:27:54.061298 18506 x:0] FATAL ERROR: error waiting on pid 15: error waiting on PID 15 in sandbox "ci-gvisor-kvm-direct-overlay-host-race-3": urpc method "containerManager.WaitPID" failed: EOF error waiting on pid 15: error waiting on PID 15 in sandbox "ci-gvisor-kvm-direct-overlay-host-race-3": urpc method "containerManager.WaitPID" failed: EOF W1213 20:27:54.069861 13536 x:0] Wait RPC to container "ci-gvisor-kvm-direct-overlay-host-race-3" failed: urpc method "containerManager.Wait" failed: EOF. Will try waiting on the sandbox process instead. D1213 20:27:54.070104 13536 x:0] Destroy container "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:54.070157 13536 x:0] Destroying container "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:54.070185 13536 x:0] Destroying root container "ci-gvisor-kvm-direct-overlay-host-race-3" by destroying sandbox D1213 20:27:54.070232 13536 x:0] Destroy sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:54.070282 13536 x:0] Killing sandbox "ci-gvisor-kvm-direct-overlay-host-race-3" D1213 20:27:54.070659 13536 x:0] Killing gofer for container "ci-gvisor-kvm-direct-overlay-host-race-3", PID: 13562 I1213 20:27:59.071206 13536 x:0] Exiting with status: 9