[2025-04-30T11:28:38.239677304Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T11:28:38.239954903Z INFO quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:33241 with scid 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a [2025-04-30T11:28:38.240005327Z TRACE quiche::tls] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a write message lvl=Initial len=621 [2025-04-30T11:28:38.240020966Z TRACE quiche::tls] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a set write secret lvl=ZeroRTT [2025-04-30T11:28:38.240040813Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Initial version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=625 pn=0 [2025-04-30T11:28:38.240043829Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm CRYPTO off=0 len=621 [2025-04-30T11:28:38.240055922Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=998.905323ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=688 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 1, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 638474488 }, next_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.240145358Z TRACE quiche_apps::client] written 1200 [2025-04-30T11:28:38.240149116Z TRACE quiche_apps::client] timed out [2025-04-30T11:28:38.240154967Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.240176948Z DEBUG quiche_apps::common] sending HTTP request "GET /jsfldqwniomjsxfmyttaqrfueklfasxebbujjylrcjfmfwrptprzkdhvhvhynjwipicdrbngvbswqrugdxysevdiucbxaankknutvrjycgdsgoggbfeuoeqxtkztcqemocydcmkurckmeomssltrxrgxrvoswncwqcwmztskpqyvpyvceohzdnmtqxeskikvrksuvgftnmndepdhegwzkoidqdgshersonhooqdgkmctrpbccltjrlcegp\r\n" [2025-04-30T11:28:38.240223044Z DEBUG quiche_apps::common] sending HTTP request "GET /jnkkjnmhpnnlscqoapiifjwavlimstxhakqnrkwczjtsummkyzpmiezjmlstbbcosgadojulqpwujfzjwzhbmxzrevprfzdxzbnpqtikkylodcopjjixeumhxlhovgxetjnympacmmtbrlewguhyocmwaieinaxhquhviwdfddkagawzozqvmvrdhbengmkcnfbcwefpmjrxaidabtisguzqxivnilfbylxqmdsabujfrsxhguqrvaptqg\r\n" [2025-04-30T11:28:38.240254021Z DEBUG quiche_apps::common] sending HTTP request "GET /vbzjhlbwfqtegyckyojeuoiprjmkyhiygntvsignwzynexjcyjpfzqxkwdbwpsdpfmdilyotdkoujrvtisijiycsgllumzqpatcqysctfhnxkrqrvxmhkerzjcmmcgmxibbnvonrwwxpyqurwsujnshsqqwvedqzowvnpmpsxmqeedjbbvhibntxnnshodowjgblctltoebhklwgkvvnsfjxngyllgtwprgvxmctcntlzlqplquaxancnm\r\n" [2025-04-30T11:28:38.240286702Z DEBUG quiche_apps::common] sending HTTP request "GET /xckoylrdryswgkuuusuhsldlwmbqnqegtspihgeulzyxuwctcggsfhbvrenhqyutcwdhkpbdpsipqntfpfiijoabxtwtxgevshobbokwmuexsnuyzhcrtnhxvdjyrwvikejtvilwhwxqcedbowoxswrqxmnepjrzdnpaoxjfeiykfmsqufaibtaygiacxtrdedbphvnzjuyidvgjiqkgtxjlxibabhpzmkaubcfcvmrdwvapkdmbyyeivd\r\n" [2025-04-30T11:28:38.240317230Z DEBUG quiche_apps::common] sending HTTP request "GET /wosdwvlmbrzbxqshnjqwzracswprisdwrfbmbanoetempqpixhdqtgtycbbowxatjodxmjpxpxeaupetsbznuwfatnuxtfnymvzotocyjvweisufntqxqgfziwftnrqouqgznffnpexsfexsrkwrgqmroabtbtfilfjzusfziepnodachhzfucdidmzzlocsrsrnidhqahcagqivhupckzhhbapcbotktckcajsccomypcbniizszdzqez\r\n" [2025-04-30T11:28:38.240339952Z DEBUG quiche_apps::common] sending HTTP request "GET /orlsezlrvehzukiveomljxcvkhdnjqaxvcgqfqmkqrvkyykhyuppdbhetnpugsahmfvyaqnalxpsgbfoozvoereeenbknhmvooiiaxycrwrakdcwmslcmgielzyoscuqkdtcsdjcnbpdamttxufatfbdsukriwbrjpqovzqasxuegqnilekeyiapfqijywtnaaktskudcucwpggvotcgieixmbwxrragmpsdzcgbopfmybzvtlerdzhwjr\r\n" [2025-04-30T11:28:38.240367293Z DEBUG quiche_apps::common] sending HTTP request "GET /piatnwitsajrcubatommnmpcydmtuickespnclbdgfvllkjwonuwrzkxdcqzjxlpfwxrgjgzwoiqqugvogzrujyjvwbdkdmhaarsaarqemasdqbpmejzewvgnvowabbwtlbtxskygzvgyynzcprkezwycytvjpqoiizdgfhzhcgcncztiovomrjtxkquyyudpefszgzqtznlvaatxxocagbhybhqemxbrehmxucgxhoxdxnhlwwaplqtcf\r\n" [2025-04-30T11:28:38.240389535Z DEBUG quiche_apps::common] sending HTTP request "GET /rneagttbympsslevoaeoptwhehllftkmkbifhpmfymrlhednughcunpheqestkzycyulgyhqxmswtpjkoojzdaberdgjqlxyiawnlmiakyplzjnakdgwkiqgsmbyxbkpcowxjtcnzisgxwyiajrutsictzfozuqswaidzjaoqjdcqxjizzdoiavwnkektbavjoopcsacmjzipymaagdjerquodikctobnuodarxvoztorklqlqmvkobnsu\r\n" [2025-04-30T11:28:38.240414091Z DEBUG quiche_apps::common] sending HTTP request "GET /vrechasutexybqcajamkmojwejobtsqqqqtqtkxcbnsyclfgxfgzstzywmnyujqxbvkzaoygkvcplmoehdjmptnlrdmcbipzvdonyjeqcgywcuezrzsxbjqvphrpokjtqdwhzntdssmmzeecpglibhcwyqttmzuljmnsydmmalomdbmwnoevwpjjiraakvdbwobdszxfrxmhbpwikhmzdcaqktctpmickucoxdfdpvjwvhnqkjvogvdryi\r\n" [2025-04-30T11:28:38.240435491Z DEBUG quiche_apps::common] sending HTTP request "GET /hxowrfvwpsmappxpirhrfbnpgqjsrltiftefptzizeditqbozngdaolhpbuywcdwzqyshtevbdnvcgiruslsiryikhzfnzfrlnavelxmhoiejhsiiyedtrbtnsledkkhminhxhuzyfenxkjscuhxjyrzvldbwblwignquroehslafxtqewwvusrjjdichjavxkpisgibibzrldjdakyfsgtkdpvyhaidiaxoyuuzsugfwbmgjwubuuuits\r\n" [2025-04-30T11:28:38.240457051Z DEBUG quiche_apps::common] sending HTTP request "GET /ggrljuxevcdjbayhzcvavyrknpekdkwjynfazptyuvrjjhmajbfmcggxsyhdipbsojxqzzaujqusykicxzthkpswvvnxkoamsbzvglmmoxqmkmbxxjpkzjizegwrkhxgpbkmhrhmpdltdtauihqwdneoebtkaqphyyvtfsrkghtvsxcazfmfgajsvsbqfbwbgwhvciwhjawjueonyahibgshxvbarhenbpdzhtgdtvxisnysteprdgirsc\r\n" [2025-04-30T11:28:38.240478240Z DEBUG quiche_apps::common] sending HTTP request "GET /cxfvtbjzyexhebignfgohzidwedoyncwaoaopvtbczjsgdfcxspvfqzueicpqvldafilwfmahjdoacajjkjobvelwqydhxbtfctzalsfyuepzkpdffodaneynvbnsqbuzasjyhtfceyntrfuoigzjkpnadvozprwqasrisyslpmfhjufleimvbrcthevxttzfvjbsfzcvammjhsjbsexqfwkuxgghjklqxyhoarhcbzkpnnnnuladbwfky\r\n" [2025-04-30T11:28:38.240516051Z DEBUG quiche_apps::common] sending HTTP request "GET /syyilgjsjodqmskvzuawqyllseyoiclohtuvvevvhriuedyyegcbfbqyqdqpthyjailisjyovtcihijssowulbtofxtbpljktynderijjtcynrmndjtmmqkqydigzzbuqvgkyvimzlcqwayeocterztraviqctbsrgvefabzpjltarxozrtxjojdnyoujsltotgtxodpmmwundakpzclstimbmlbuqggcwrksuvweroewrblxdonhnzzzc\r\n" [2025-04-30T11:28:38.240541879Z DEBUG quiche_apps::common] sending HTTP request "GET /opfqidslmkhsujnlepawngygiacdgdtwaybfpmuwkvbvseyuyfjzqbypndaicdsxnwwxxuekpsolsntxtvlwewggbeehnslbgmhkspsmrdumctbemfwmkpfqarhlmrlsmvyakdoxrnwlmepzdsvpdpdzjzziwkrjldmntcquksauojihngwrtlsxwlchxpigflcipvwwhjatgofvnqbubterqyyhdwevdmevzeeuffobqrwwewonaucfzr\r\n" [2025-04-30T11:28:38.240567186Z DEBUG quiche_apps::common] sending HTTP request "GET /mkovfwbcwsqxkwaxpsglgtudehtpmmtiyjqzjjkwhxlzfqaofvjxolgoebrvucvzauplvxvarcpkkttzxmdxzqpyqwuzgzuvqpkkpzpcolxmihvatlmlzqwadqnshdrrnelzqxemzcxsfcmakaknpavlqayimclxcfzmivtojlmcjoutwwtcrrrkqhlylyndylsyrjyknhnouhrsoicvfisatlgszwwcigovfdkaiuxebeutwyojqutwim\r\n" [2025-04-30T11:28:38.240629172Z DEBUG quiche_apps::common] sending HTTP request "GET /wnbrewjoxacjkxbpjskresnrtbodaqraozzrtfucmoojalcshhaxehayhslpvivxvsxzfhnsggiwzsgdogvikhzmfvpzdzojskqyqcybchkarjupacvxphfaxyqmislnkipswpqazkgontupntxbayujvlpjyzsfypdwctobowjgsvrljhqizvuyqbphtpmojgrggxeejaqtnnobvaynxherpjoudjdavzndskmlegwstpenkzktonfrdp\r\n" [2025-04-30T11:28:38.240654830Z DEBUG quiche_apps::common] sending HTTP request "GET /bwlpqzxxxzruihharuhvdhbsezgkvtilrxukhfsycrcmgljayvorovyyghsuvlapfehmxqjivqgalomwespitlcyjxunffjwsyrirxogikntbafqnumgqslirmshntunqnzluvowsvflwjrcvyxigjohakjbgyzgekhzcyzedoocdvbjebzvijfrsetmgqrdncbcdwuaeilrhrbilwenuhgpgrwktodxsshylhxgwamicgnjmnvjltpndm\r\n" [2025-04-30T11:28:38.240678334Z DEBUG quiche_apps::common] sending HTTP request "GET /rjulxzdgpnfqenlscwaiwixhjbyafvurzpfkuaxmknpompfrczljwhryhldgvqxmzjhpaepkbarynqlkxisjklrisiukmjfvqqwpasivjkskuyfvpwpdnuyflxtckmwnylwcvcvcjnxzfaqvlhmplemijlqendblmxuepilbuangurbczeltqsgubywcdhswxgsbfzljmribrrymnichchgykyppkwgbutauwbjknqockfbdgthzzqovkj\r\n" [2025-04-30T11:28:38.240705956Z DEBUG quiche_apps::common] sending HTTP request "GET /cacqieonrxgdsiuphppmcjdhfclozbzxwpuwuepamvjsnqcbiybmllsfarxgvpgnswcfdtlmfwnjmpcvqlozmrdadpbyslbwmxgzdtcmihbrfnmzkwypnenutarqipvpwvlkpwqltwhcodhdvmwicgjzfzkvcunhkjqxwuazvwrgdefjaksqdjjcgdthzinzcpbofxcsfrfeezbtptwmscnvxkdncsavchygelyhllzevydwmpncjaunww\r\n" [2025-04-30T11:28:38.240729239Z DEBUG quiche_apps::common] sending HTTP request "GET /yalvziezkkgbezpsgkfdixdwzbhqujwvetbynydzkouxyoboxsivpabokjufariazppljosytnnqeifqgavyddjtjsrnmdpbeewkbxfckvtbqzbpkmnnjypypnttnkfovowvmerscguranvjadeuylgciamrasnzjppoanekydrjtpjkllzgytfrvphmroteahvocwxetakazzocveqhjfbknnlrvgrcipyyddgxruzubhlyujxvvatmej\r\n" [2025-04-30T11:28:38.240753174Z DEBUG quiche_apps::common] sending HTTP request "GET /ryvaaunikqestzuorvmapaibbetpuimiiyjnddavtizjbsbnwlpclbhfjmvoibyziqmbiovchtkivzrelohfcnlrgsyckxasxuefomsqpcjalelsfwqoxdstfibprdbbmixvjfvhvumqttgobcbwhwqvdejroasskdpkhlqukjpwmmrgvmayojgejcyhlrnkdqqyulbgjxylhhqjvptrtrmfvjiqxlbwazrclsrbgfsadhsguimlvrnhko\r\n" [2025-04-30T11:28:38.240776067Z DEBUG quiche_apps::common] sending HTTP request "GET /otrobgfjkwaqiqarfkoupckxctvhrhkecohzxhdxutkbgkgtqydpdynlpwezrqqcsdpbgzzjogzzjhmmttcpmalldgzlidbojvsgybkjtxctokgghbqwoxskmjbhsvroxnvvmixdkknlpiwlvbxekmzyipbyevsrnqyinsqmikgbskyixclwkcxodwabhfdhzfrnrgsaprlywdfqwejuppbgkyfjjjfcjmgyyybkegnojagyiwxilblqhq\r\n" [2025-04-30T11:28:38.240798669Z DEBUG quiche_apps::common] sending HTTP request "GET /kvebfdyexodmjgsjpuandwvkbmjcagiwvpqosaozmnupsxtrtlkavjqmzxwdzzargugtxuoeyvsxkerrxrgofbospfdykekvctcftgqdhgdtghwurexhmikusvgyxkdzhdcgimsocnxdwgxczfoxoshsvpkfdzfqesewmhjzqesitndzozkxjregrauggtyheahglekojaewqjhkdowzwetzhzjmnxjcsnyfxkseircywfbkdzkeaibdme\r\n" [2025-04-30T11:28:38.240822604Z DEBUG quiche_apps::common] sending HTTP request "GET /iumtzjtpuhtuejzubfgayvtgevrwhjnspqskyldgdgbcjjderyshoylkjobajdfeufsggbnfprclgxpixorfchniyryunezfyadvrbueuhpqlpcczwdbhywkqpyfuzwsblxqjovzfrojndfqbeoztlwzdhtmxpceamrmmrskgshfouatmiklflsjitdymqwijgkhosjsmstqgnqyouybhuenvtsjrjejtaicmgqbpbxighgufmqpgqeqjk\r\n" [2025-04-30T11:28:38.240847590Z DEBUG quiche_apps::common] sending HTTP request "GET /rllvhtbrfozjccftwcmofrveujiuylpncaisaufzzkqdindpsxddeigyxtcwrqhzikmytoatgvxbbcfvjkdekvbokkqcxukkiibavkjigbziloujvuivitzisgtuuftbbhxdeeemjoixccwvwvvzeylqwzotzgkwmpprvswotqsedytmbcgnqtumsepsvpqitfytpwzgtyurgwbqqrwswvswshztwxvqiwdfamtdavazeowiskgbrzxiqf\r\n" [2025-04-30T11:28:38.240870673Z DEBUG quiche_apps::common] sending HTTP request "GET /eizsemrgquiqzqrzotrmvdbyfghlwfyezpgpczrdwynfeyamzcucyqwquactgffafrtyiugvotoqfbfeghipfwowkhhygzmkeszcpmodqwkqccyucjeqgfwpnnswcmjdlykvatzrzyxqlrhoclprdzbtgfwnwhsqxucgjczcjpbjtkrwuroohrvazzklxhdpkatuirzenzzwqlbbrjdhhubuurqvuxotdkdrgchdjiylwdciabqfzndxeb\r\n" [2025-04-30T11:28:38.240894698Z DEBUG quiche_apps::common] sending HTTP request "GET /scxsrswfjcdnjskkbrgxxcrdcrjwukoohjtllragcmpuvlpwuihfnjuvlbgmlwdondxwjhfdvvshivfpsazwtgehszggijcwgkfmxugbubaptzgrpvniuvimsgcdlkeafoxkyoadyretysuieoqsnnzofxaczakifftmmtdytfelgrmwzieeqxvfharfodurhzknyuzdjaotqypgvvmezjihwtwaocyzswmndukftqvplhqclumtbehbky\r\n" [2025-04-30T11:28:38.240918493Z DEBUG quiche_apps::common] sending HTTP request "GET /wiylskbmswxwlqmyzhcgxcxpfaxwvegunwgmdwhnuabvwggyvprhqfgozghliknnwamywepgnudewvirhdkhevvdrrfabzlhrxlhoydowmxnjapfgrtcjsdbfqgkdeenunuulvvytqzolusqxsdpmmwaiylaswbnuwxgsgpxkknnyqzuekxoyzwahfyqijjygpsexizrzahaombvrtslphtasecwzyrkrtdksmnuulgrxujezsrhcatwws\r\n" [2025-04-30T11:28:38.240963758Z DEBUG quiche_apps::common] sending HTTP request "GET /dxlqcidovfcalnsrphhjsuhwajcxurogaososmplmwhmramcqhbklnyjljsbidtufikrdwjsxedqvopnjoptuvylusmqyemwuflhnznlzxrloehvgyomrpykrfwugzfwcswemjpbzqjbgpahocfjrkllcdfboxurbgcdlgltjjwryzsxlqndhmqslbvftsfzckfbhwszqqwqoqmjpgyirkwlsujuyvmagdmbxeqcocmvqswfblptomodec\r\n" [2025-04-30T11:28:38.240988994Z DEBUG quiche_apps::common] sending HTTP request "GET /qlivcxqdxyliqlylkpbtgyylcflsjifuwoeaaxfvmfebwjtzstvhmomvpmutfsjyypcjwitwbefyzundbidhstjvogncpqyipjowbyegrtahxdiuwxajaqhuskndiqdrwlxzzvqlluhhbapmovplzbvyvlyzdoesbkwpjtsmffocywkibqtgurajelabksbqmiydltcwesndehdnpffekqnbvjtgucsvwxvlidrjkmmugkzoiaiwgnllgy\r\n" [2025-04-30T11:28:38.241018640Z DEBUG quiche_apps::common] sending HTTP request "GET /uqexbbrbisisgmikwpbhxkycxbvjctdqrxvayxbrahitwsryafjpsfpisshdmzcxxtjtgnlkseuntufmtjhzvcxyikgjirjxdvzducetaavvueowhwbhtnydvwpnbwjbflqzaujivdiwnhhsfrfwpftrceeoqkbxpescqyevcrmvkalcpjpxvxkcdprihfqtnimmppscjwoafuozlcprkvfwdfnvqheygjiephjqyhirnmiwzladohnsvd\r\n" [2025-04-30T11:28:38.241042034Z DEBUG quiche_apps::common] sending HTTP request "GET /sobnjwckjuhmsjcodpiiyaasndjcsdkwiezmytqdjodbxquwckvhexxojlfvfrkaxlqsikrgeefdflmmiovgojbvqhlciwwkxejmrnvmflnchhytrxnufmpcddvxbxkdagyjucngdgeohaxncoawvexlhnppzwhwykiqppwwcfjaqhkeyssnbwtfekxmsahfyefwjijfzxnbqybhwivloyezzwjwqjflxqwigvlbsppsndlrpobnvlxyxd\r\n" [2025-04-30T11:28:38.241065067Z DEBUG quiche_apps::common] sending HTTP request "GET /sbyngujqygoitollufwbdddkzlpyyicpxsdawkiuxslczffejqvuwaqzmzxifcjntcdzumrtfdhjedxmgfhemircrjxswdlmmijhtvqzrocpvvrreubvedizvllorjlvjekqorqkvxrodwayhpgpacheajluuelnraysnvlqoiwplqvpagaarnnavuowgkmjyrdhuibptyoxldngggoykznzwoqjxumqijhklgpykikkslquwmoweyytin\r\n" [2025-04-30T11:28:38.241091045Z DEBUG quiche_apps::common] sending HTTP request "GET /kwytiogedbbwctyjbvngurthsypxvspzaqpurtiuqsbivxxqfrzbosanszojzyvnwxdrkuvokuofcqcarlqosxioanuqnnikkfvffzpkifduggobkstztqhhgouzsvinxwnsfqlvwnwobonujzupjeuldhdhzrjzmipmqqwtrlfxfxminqnhxlzlilvvikjrioyccwncfnyvoxmvmnnslcktactjogvwldkriceionevlbkrkkylvjdnnn\r\n" [2025-04-30T11:28:38.241117815Z DEBUG quiche_apps::common] sending HTTP request "GET /rvhgwbqqispqmjoriuiewtlgwkcmeuhyewnwjpqmexnpiffmxkcctquqxbwwfpnmdljdikecmqtmdwraqngfdryxwqnoqrtuafwgwurrixtiaynnzqsxenrmrkobkxkpyhqhxanexqlhtsrovkjssdmidswnvjhcavzrrezyrmhjeddwvszamgjgxnpvpbdvisitxhjqhaubqqbwlegvvkqngpztxuaedqkgljbebzqejligxxfgnblada\r\n" [2025-04-30T11:28:38.241165354Z DEBUG quiche_apps::common] sending HTTP request "GET /tcvfipesoaizaraiimcmlqpxcmxonwbvvehigfcbahrqtizogfwpmvnqrbacssxfgxdmyfdcxwefbgzmtlbfikqxbihlkleksbmpzlnwpuzuydrrsovbpfpmhyrmbwvkjiwsymfbitutgfsawcpnigcjammkvhrghqqawkufhtegxvxminauvxnhhdkjtambqxtckrqtpocqtcfwxnidgyeocaiueibbhlfzmnlujlwkuaeaafdvrnrxkb\r\n" [2025-04-30T11:28:38.241192705Z DEBUG quiche_apps::common] sending HTTP request "GET /imnymvgxwergerdjpuydjbkruwiiunlnuqicyeggqarelvibxgytpgykffpllhcisjojnkvgwngxxindeewugdocxfttmmdyqjhkwrdxrorjytlvtrlqpjoqdwtcdwbkhuiptstxgfmyemulcpiwiirzosjlfddeugfzizhchbssyfbjskratseqjbtvfkpkjvgvprpqflfgklabdlcktqgljxvxjxbwjvrvcgxmvoaxdkhugvcknqermg\r\n" [2025-04-30T11:28:38.241234403Z DEBUG quiche_apps::common] sending HTTP request "GET /qqlftardumbniwqwjgwtjijqpgaproqjwmsvhqvymplvpomvuxpgtjmbaurlnzgbrmcxcuwxuzpergpfwlasjhwinqgzrqcsohypqwwltpdxenapszmonutwchnyqbhfymkxljuhucfhwwcinmfffqbqurklsyoilffiaepfpadycfjgbccchtezikbhhtgekychlnwwenhmpfvmktmmssjoqdggojdrnzvzezqvxvcfxqyagzadpxtiot\r\n" [2025-04-30T11:28:38.241266854Z DEBUG quiche_apps::common] sending HTTP request "GET /vkvjtammjxionyvionxwgmvpbudfibvckbuhluubbnvioytfinfkzhbpcflyfgputamldckweygehachfqyjrmrmrttzcubjbftjvuwrogkiuopmusxnfxpqgqpuzqhvpnyvqofgfvvotrcbptbyzcnfujucvuifkjdmdregzginhlltewpuqlwakowwhyluztuyqunyowooexlfjmbaxgeimrutgvpgrjcktvyprfhflzheipakefmsem\r\n" [2025-04-30T11:28:38.241309303Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=1 [2025-04-30T11:28:38.241313100Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=0 off=0 len=257 fin=true [2025-04-30T11:28:38.241321586Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.639959ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1012 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639812888 }, next_time: Instant { tv_sec: 392, tv_nsec: 639812888 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241340381Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=2 [2025-04-30T11:28:38.241343066Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=4 off=0 len=257 fin=true [2025-04-30T11:28:38.241347785Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.61381ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1336 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639812888 }, next_time: Instant { tv_sec: 392, tv_nsec: 639812888 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241359236Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=3 [2025-04-30T11:28:38.241361751Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=8 off=0 len=257 fin=true [2025-04-30T11:28:38.241365919Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.595746ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1660 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639812888 }, next_time: Instant { tv_sec: 392, tv_nsec: 639812888 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241377010Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=166 pn=4 [2025-04-30T11:28:38.241382470Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=12 off=0 len=161 fin=false [2025-04-30T11:28:38.241400964Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.560621ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1888 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639812888 }, next_time: Instant { tv_sec: 392, tv_nsec: 639812888 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241437823Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.241451248Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=5 [2025-04-30T11:28:38.241455646Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=16 off=0 len=257 fin=true [2025-04-30T11:28:38.241466767Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.494247ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2212 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639954303 }, next_time: Instant { tv_sec: 392, tv_nsec: 639954303 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241507002Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=6 [2025-04-30T11:28:38.241516660Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=20 off=0 len=257 fin=true [2025-04-30T11:28:38.241526769Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.434385ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2536 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639954303 }, next_time: Instant { tv_sec: 392, tv_nsec: 639954303 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241547077Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=7 [2025-04-30T11:28:38.241549632Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=24 off=0 len=257 fin=true [2025-04-30T11:28:38.241554160Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.407505ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2860 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639954303 }, next_time: Instant { tv_sec: 392, tv_nsec: 639954303 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241565021Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=166 pn=8 [2025-04-30T11:28:38.241567485Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=28 off=0 len=161 fin=false [2025-04-30T11:28:38.241571693Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.390002ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3088 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 639954303 }, next_time: Instant { tv_sec: 392, tv_nsec: 639954303 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241604524Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.241617208Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=9 [2025-04-30T11:28:38.241621356Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=32 off=0 len=257 fin=true [2025-04-30T11:28:38.241638538Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.322596ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3412 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 8, last_sent_packet: 9, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640120694 }, next_time: Instant { tv_sec: 392, tv_nsec: 640120694 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241662232Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=10 [2025-04-30T11:28:38.241666470Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=36 off=0 len=257 fin=true [2025-04-30T11:28:38.241671820Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.289785ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3736 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 10, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640120694 }, next_time: Instant { tv_sec: 392, tv_nsec: 640120694 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241683101Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=11 [2025-04-30T11:28:38.241685656Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=40 off=0 len=257 fin=true [2025-04-30T11:28:38.241689994Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.271691ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4060 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 11, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640120694 }, next_time: Instant { tv_sec: 392, tv_nsec: 640120694 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241704682Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=166 pn=12 [2025-04-30T11:28:38.241707196Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=44 off=0 len=161 fin=false [2025-04-30T11:28:38.241711464Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.250221ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4288 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 12, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640120694 }, next_time: Instant { tv_sec: 392, tv_nsec: 640120694 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241743675Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.241757310Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=13 [2025-04-30T11:28:38.241761898Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=48 off=0 len=257 fin=true [2025-04-30T11:28:38.241771617Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.189548ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4612 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 13, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640260504 }, next_time: Instant { tv_sec: 392, tv_nsec: 640260504 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241794249Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=14 [2025-04-30T11:28:38.241797264Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=52 off=0 len=257 fin=true [2025-04-30T11:28:38.241802294Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.159331ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4936 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 14, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640260504 }, next_time: Instant { tv_sec: 392, tv_nsec: 640260504 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241818063Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=262 pn=15 [2025-04-30T11:28:38.241820588Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=56 off=0 len=257 fin=true [2025-04-30T11:28:38.241824916Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.136769ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5260 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 15, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640260504 }, next_time: Instant { tv_sec: 392, tv_nsec: 640260504 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241835446Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=166 pn=16 [2025-04-30T11:28:38.241837931Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=60 off=0 len=161 fin=false [2025-04-30T11:28:38.241842078Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.119607ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5488 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 16, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640260504 }, next_time: Instant { tv_sec: 392, tv_nsec: 640260504 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241875811Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.241889808Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=17 [2025-04-30T11:28:38.241894586Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=64 off=0 len=257 fin=true [2025-04-30T11:28:38.241911027Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.050067ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5813 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 17, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640392942 }, next_time: Instant { tv_sec: 392, tv_nsec: 640392942 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241934441Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=18 [2025-04-30T11:28:38.241937827Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=68 off=0 len=257 fin=true [2025-04-30T11:28:38.241943157Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.018468ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6138 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 18, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640392942 }, next_time: Instant { tv_sec: 392, tv_nsec: 640392942 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241954318Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=19 [2025-04-30T11:28:38.241956802Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=72 off=0 len=257 fin=true [2025-04-30T11:28:38.241961010Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=997.000685ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6463 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 19, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640392942 }, next_time: Instant { tv_sec: 392, tv_nsec: 640392942 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.241976189Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=163 pn=20 [2025-04-30T11:28:38.241978734Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=76 off=0 len=157 fin=false [2025-04-30T11:28:38.241982962Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.978734ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6688 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 20, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640392942 }, next_time: Instant { tv_sec: 392, tv_nsec: 640392942 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242014420Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.242027685Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=21 [2025-04-30T11:28:38.242032123Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=80 off=0 len=257 fin=true [2025-04-30T11:28:38.242059194Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.90173ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7013 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 21, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640531030 }, next_time: Instant { tv_sec: 392, tv_nsec: 640531030 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242077568Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=22 [2025-04-30T11:28:38.242083329Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=84 off=0 len=257 fin=true [2025-04-30T11:28:38.242088419Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.873237ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7338 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 22, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640531030 }, next_time: Instant { tv_sec: 392, tv_nsec: 640531030 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242099119Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=23 [2025-04-30T11:28:38.242101603Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=88 off=0 len=257 fin=true [2025-04-30T11:28:38.242105731Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.855955ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7663 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 23, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640531030 }, next_time: Instant { tv_sec: 392, tv_nsec: 640531030 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242116671Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=163 pn=24 [2025-04-30T11:28:38.242119136Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=92 off=0 len=157 fin=false [2025-04-30T11:28:38.242123284Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.838402ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7888 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 24, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640531030 }, next_time: Instant { tv_sec: 392, tv_nsec: 640531030 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242161465Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.242176032Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=25 [2025-04-30T11:28:38.242180891Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=96 off=0 len=257 fin=true [2025-04-30T11:28:38.242190650Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.770495ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8213 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 25, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640678986 }, next_time: Instant { tv_sec: 392, tv_nsec: 640678986 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242212660Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=26 [2025-04-30T11:28:38.242215396Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=100 off=0 len=257 fin=true [2025-04-30T11:28:38.242220335Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.741321ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8538 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 26, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640678986 }, next_time: Instant { tv_sec: 392, tv_nsec: 640678986 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242230975Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=27 [2025-04-30T11:28:38.242233449Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=104 off=0 len=257 fin=true [2025-04-30T11:28:38.242242446Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.719229ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8863 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 27, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640678986 }, next_time: Instant { tv_sec: 392, tv_nsec: 640678986 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242253517Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=163 pn=28 [2025-04-30T11:28:38.242255992Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=108 off=0 len=157 fin=false [2025-04-30T11:28:38.242260119Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.701556ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9088 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 28, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640678986 }, next_time: Instant { tv_sec: 392, tv_nsec: 640678986 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242291117Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.242301707Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=29 [2025-04-30T11:28:38.242306346Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=112 off=0 len=257 fin=true [2025-04-30T11:28:38.242315743Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.645451ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9413 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 29, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640807156 }, next_time: Instant { tv_sec: 392, tv_nsec: 640807156 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242344297Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=30 [2025-04-30T11:28:38.242348895Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=116 off=0 len=257 fin=true [2025-04-30T11:28:38.242356479Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.605016ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9738 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 30, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640807156 }, next_time: Instant { tv_sec: 392, tv_nsec: 640807156 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242367870Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=31 [2025-04-30T11:28:38.242370345Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=120 off=0 len=257 fin=true [2025-04-30T11:28:38.242374643Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.587012ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10063 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 31, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640807156 }, next_time: Instant { tv_sec: 392, tv_nsec: 640807156 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242385093Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=163 pn=32 [2025-04-30T11:28:38.242387597Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=124 off=0 len=157 fin=false [2025-04-30T11:28:38.242391715Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.56997ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10288 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 32, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640807156 }, next_time: Instant { tv_sec: 392, tv_nsec: 640807156 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242426239Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.242440576Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=33 [2025-04-30T11:28:38.242445405Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=128 off=0 len=257 fin=true [2025-04-30T11:28:38.242461185Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.499919ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10613 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 33, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640944232 }, next_time: Instant { tv_sec: 392, tv_nsec: 640944232 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242485510Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=34 [2025-04-30T11:28:38.242508293Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=132 off=0 len=257 fin=true [2025-04-30T11:28:38.242514775Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.44681ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10938 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 34, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640944232 }, next_time: Instant { tv_sec: 392, tv_nsec: 640944232 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242531486Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=35 [2025-04-30T11:28:38.242534031Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=136 off=0 len=257 fin=true [2025-04-30T11:28:38.242541044Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.420641ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11263 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 35, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640944232 }, next_time: Instant { tv_sec: 392, tv_nsec: 640944232 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242551784Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=163 pn=36 [2025-04-30T11:28:38.242554249Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=140 off=0 len=157 fin=false [2025-04-30T11:28:38.242558527Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.403139ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11488 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 36, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 640944232 }, next_time: Instant { tv_sec: 392, tv_nsec: 640944232 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242589976Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.242598912Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=37 [2025-04-30T11:28:38.242603150Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=144 off=0 len=257 fin=true [2025-04-30T11:28:38.242612828Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.348306ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11813 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 37, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641105974 }, next_time: Instant { tv_sec: 392, tv_nsec: 641105974 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242642123Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=38 [2025-04-30T11:28:38.242646872Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=148 off=0 len=257 fin=true [2025-04-30T11:28:38.242653484Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.308011ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12138 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 38, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641105974 }, next_time: Instant { tv_sec: 392, tv_nsec: 641105974 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242664985Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=263 pn=39 [2025-04-30T11:28:38.242667470Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=152 off=0 len=257 fin=true [2025-04-30T11:28:38.242682418Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.279237ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12463 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 39, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641105974 }, next_time: Instant { tv_sec: 392, tv_nsec: 641105974 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242693349Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=102 pn=40 [2025-04-30T11:28:38.242698368Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=12 off=161 len=96 fin=true [2025-04-30T11:28:38.242702936Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.258749ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12627 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 40, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641105974 }, next_time: Instant { tv_sec: 392, tv_nsec: 641105974 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242737070Z TRACE quiche_apps::client] written 1139 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.242749974Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=102 pn=41 [2025-04-30T11:28:38.242754142Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=28 off=161 len=96 fin=true [2025-04-30T11:28:38.242763981Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.197174ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12791 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 41, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641253119 }, next_time: Instant { tv_sec: 392, tv_nsec: 641253119 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242786533Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=102 pn=42 [2025-04-30T11:28:38.242790711Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=44 off=161 len=96 fin=true [2025-04-30T11:28:38.242795820Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.165795ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12955 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 42, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641253119 }, next_time: Instant { tv_sec: 392, tv_nsec: 641253119 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242811189Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=102 pn=43 [2025-04-30T11:28:38.242813754Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=60 off=161 len=96 fin=true [2025-04-30T11:28:38.242818082Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.143584ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13119 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 43, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641253119 }, next_time: Instant { tv_sec: 392, tv_nsec: 641253119 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242828501Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=107 pn=44 [2025-04-30T11:28:38.242830966Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=76 off=157 len=100 fin=true [2025-04-30T11:28:38.242835113Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.126562ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13288 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 44, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641253119 }, next_time: Instant { tv_sec: 392, tv_nsec: 641253119 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242845603Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt ZeroRTT version=1 dcid=a8b95dcd1f6ca01462f5684f84ba0890 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=107 pn=45 [2025-04-30T11:28:38.242848067Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=92 off=157 len=100 fin=true [2025-04-30T11:28:38.242854750Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=996.106945ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13457 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 45, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 392, tv_nsec: 641253119 }, next_time: Instant { tv_sec: 392, tv_nsec: 641253119 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.242888674Z TRACE quiche_apps::client] written 830 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.242900716Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.272980248Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.272997901Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Initial version=1 dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a scid=c3022cd912673a0021 token= len=125 pn=0 [2025-04-30T11:28:38.273009973Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=1 blocks=[0..0] ecn_counts=None [2025-04-30T11:28:38.273015644Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 0 [2025-04-30T11:28:38.273021305Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm CRYPTO off=0 len=96 [2025-04-30T11:28:38.273114018Z TRACE quiche::tls] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a set write secret lvl=Handshake [2025-04-30T11:28:38.273125339Z TRACE quiche::tls] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a set read secret lvl=Handshake [2025-04-30T11:28:38.273148903Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Handshake version=1 dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a scid=c3022cd912673a0021 len=1018 pn=1 [2025-04-30T11:28:38.273155205Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm CRYPTO off=0 len=195 [2025-04-30T11:28:38.273191472Z TRACE quiche::tls] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a write message lvl=Handshake len=52 [2025-04-30T11:28:38.273194979Z TRACE quiche::tls] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a set write secret lvl=OneRTT [2025-04-30T11:28:38.273203916Z TRACE quiche::tls] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a set read secret lvl=OneRTT [2025-04-30T11:28:38.273223472Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a connection established: proto=Ok("hq-interop") cipher=Some(AES256_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=true TransportParams { original_destination_connection_id: Some(a8b95dcd1f6ca01462f5684f84ba0890), max_idle_timeout: 30000, stateless_reset_token: Some(281935047534031627421803571744909322998), max_udp_payload_size: 1472, initial_max_data: 16777216, initial_max_stream_data_bidi_local: 65536, initial_max_stream_data_bidi_remote: 65536, initial_max_stream_data_uni: 65536, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 8, max_ack_delay: 26, disable_active_migration: false, active_conn_id_limit: 4, initial_source_connection_id: Some(c3022cd912673a0021), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T11:28:38.273237739Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm PADDING len=799 [2025-04-30T11:28:38.273259450Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 1220 bytes [2025-04-30T11:28:38.273266693Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.273271061Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=2 [2025-04-30T11:28:38.273276832Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..4] ecn_counts=None [2025-04-30T11:28:38.273280569Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 1 [2025-04-30T11:28:38.273283424Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 2 [2025-04-30T11:28:38.273286099Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 3 [2025-04-30T11:28:38.273288704Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 4 [2025-04-30T11:28:38.273292752Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16777730 [2025-04-30T11:28:38.273304363Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.273309904Z TRACE quiche_apps::client] got 149 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.273313691Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=128 pn=3 [2025-04-30T11:28:38.273318450Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=0 off=0 len=32 fin=true [2025-04-30T11:28:38.273322257Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=4 off=0 len=32 fin=true [2025-04-30T11:28:38.273325653Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=8 off=0 len=32 fin=true [2025-04-30T11:28:38.273332005Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 149 bytes [2025-04-30T11:28:38.273336303Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.273339309Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.273346081Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.273349237Z TRACE quiche_apps::common] stream 0 has 32 bytes (fin? true) [2025-04-30T11:28:38.273352273Z DEBUG quiche_apps::common] 1/39 responses received [2025-04-30T11:28:38.273356501Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.273359166Z TRACE quiche_apps::common] stream 4 has 32 bytes (fin? true) [2025-04-30T11:28:38.273361921Z DEBUG quiche_apps::common] 2/39 responses received [2025-04-30T11:28:38.273365878Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.273368574Z TRACE quiche_apps::common] stream 8 has 32 bytes (fin? true) [2025-04-30T11:28:38.273371279Z DEBUG quiche_apps::common] 3/39 responses received [2025-04-30T11:28:38.273382980Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Initial version=1 dcid=c3022cd912673a0021 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=5 pn=46 [2025-04-30T11:28:38.273386387Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=48 blocks=[0..0] ecn_counts=None [2025-04-30T11:28:38.273394241Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=78.858115ms latest_rtt=31.969924ms srtt=32.900027ms min_rtt=31.969924ms rttvar=12.653081ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=11569 app_limited=false congestion_recovery_start_time=None Rate { delivered: 1888, delivered_time: Instant { tv_sec: 392, tv_nsec: 671782812 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 46, largest_acked: 4, rate_sample: RateSample { delivery_rate: 57155, is_app_limited: true, interval: 33.0329ms, delivered: 1888, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 564209, last_update: Instant { tv_sec: 392, tv_nsec: 671734211 }, next_time: Instant { tv_sec: 392, tv_nsec: 671734241 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=None last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=31.969924ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=5 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.273419509Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Handshake version=1 dcid=c3022cd912673a0021 scid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a len=61 pn=47 [2025-04-30T11:28:38.273423025Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=33 blocks=[1..1] ecn_counts=None [2025-04-30T11:28:38.273426291Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm CRYPTO off=0 len=52 [2025-04-30T11:28:38.273435158Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=78.817219ms latest_rtt=31.969924ms srtt=32.900027ms min_rtt=31.969924ms rttvar=12.653081ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=11685 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1888, delivered_time: Instant { tv_sec: 392, tv_nsec: 671782812 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 47, largest_acked: 4, rate_sample: RateSample { delivery_rate: 57155, is_app_limited: true, interval: 33.0329ms, delivered: 1888, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 564209, last_update: Instant { tv_sec: 392, tv_nsec: 671888359 }, next_time: Instant { tv_sec: 392, tv_nsec: 671734241 }, max_datagram_size: 1350, last_packet_size: None, iv: 205.598µs, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.273448663Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a dropped epoch 0 state [2025-04-30T11:28:38.273453983Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=3165 out_len=1173 left=1141 [2025-04-30T11:28:38.273466767Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=1146 pn=48 [2025-04-30T11:28:38.273469993Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=17 blocks=[2..3] ecn_counts=None [2025-04-30T11:28:38.273473159Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[54, a5, c4, f1, 60, fa, 43, 6e, 9d, 6e, db, c9, 0f, 5c, 4e, 6f, 57, 4c, 58, af] reset_token=[47, 95, e2, 5a, a9, f9, 74, 03, 05, 0a, b5, bf, db, 05, f8, 62] [2025-04-30T11:28:38.273481174Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[38, 44, 24, 06, 21, 5f, 63, ec, f0, be, 18, 4c, 33, 32, 47, ac, 8a, 14, 6c, 6b] reset_token=[72, 9a, ff, 1f, 18, e4, 3c, 74, 2b, 63, 80, 80, 86, fd, a9, f8] [2025-04-30T11:28:38.273487556Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[0b, c2, 3e, 15, fa, a4, ad, 6a, 89, 9b, 05, 25, 22, c1, 7a, 67, b1, 8b, 37, 90] reset_token=[6b, 3c, 84, ee, 32, 7b, d2, 11, 22, 63, 6b, 62, 3e, 9c, 17, 2a] [2025-04-30T11:28:38.273520587Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=108 off=157 len=100 fin=true [2025-04-30T11:28:38.273523283Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm PADDING len=914 [2025-04-30T11:28:38.273541887Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=83.34582ms latest_rtt=31.969924ms srtt=32.900027ms min_rtt=31.969924ms rttvar=12.653081ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=12858 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1888, delivered_time: Instant { tv_sec: 392, tv_nsec: 671782812 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 48, largest_acked: 4, rate_sample: RateSample { delivery_rate: 57155, is_app_limited: true, interval: 33.0329ms, delivered: 1888, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 1173, rate: 564209, last_update: Instant { tv_sec: 392, tv_nsec: 671888359 }, next_time: Instant { tv_sec: 392, tv_nsec: 672093957 }, max_datagram_size: 1350, last_packet_size: Some(1173), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.273581832Z TRACE quiche_apps::client] written 1350 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.273588384Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=1992 out_len=1350 left=1323 [2025-04-30T11:28:38.273592271Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=107 pn=49 [2025-04-30T11:28:38.273596279Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=124 off=157 len=100 fin=true [2025-04-30T11:28:38.273605446Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=83.282ms latest_rtt=31.969924ms srtt=32.900027ms min_rtt=31.969924ms rttvar=12.653081ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=12992 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1888, delivered_time: Instant { tv_sec: 392, tv_nsec: 671782812 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 49, largest_acked: 4, rate_sample: RateSample { delivery_rate: 57155, is_app_limited: true, interval: 33.0329ms, delivered: 1888, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 564209, last_update: Instant { tv_sec: 392, tv_nsec: 672098352 }, next_time: Instant { tv_sec: 392, tv_nsec: 672093957 }, max_datagram_size: 1350, last_packet_size: None, iv: 2.316517ms, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.273653305Z TRACE quiche_apps::client] written 134 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.273665037Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=1858 out_len=1350 left=1323 [2025-04-30T11:28:38.273670848Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=107 pn=50 [2025-04-30T11:28:38.273675136Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm STREAM id=140 off=157 len=100 fin=true [2025-04-30T11:28:38.273685034Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=83.202422ms latest_rtt=31.969924ms srtt=32.900027ms min_rtt=31.969924ms rttvar=12.653081ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=13126 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1888, delivered_time: Instant { tv_sec: 392, tv_nsec: 671782812 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 50, largest_acked: 4, rate_sample: RateSample { delivery_rate: 57155, is_app_limited: true, interval: 33.0329ms, delivered: 1888, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 134, rate: 564209, last_update: Instant { tv_sec: 392, tv_nsec: 672098352 }, next_time: Instant { tv_sec: 392, tv_nsec: 674489688 }, max_datagram_size: 1350, last_packet_size: Some(134), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.273730800Z TRACE quiche_apps::client] written 134 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.273736471Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.273905877Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.273913561Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=4 [2025-04-30T11:28:38.273919613Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..8] ecn_counts=None [2025-04-30T11:28:38.273923139Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 5 [2025-04-30T11:28:38.273925634Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 6 [2025-04-30T11:28:38.273927818Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 7 [2025-04-30T11:28:38.273929952Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 8 [2025-04-30T11:28:38.273933338Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16778662 [2025-04-30T11:28:38.273945341Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.273949158Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.273951532Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.273958225Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=2924 out_len=1350 left=1318 [2025-04-30T11:28:38.273961451Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=51 [2025-04-30T11:28:38.273963875Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[2..4] ecn_counts=None [2025-04-30T11:28:38.273969596Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=70.640975ms latest_rtt=32.470448ms srtt=32.846329ms min_rtt=31.969924ms rttvar=9.597204ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=11926 app_limited=true congestion_recovery_start_time=None Rate { delivered: 3088, delivered_time: Instant { tv_sec: 392, tv_nsec: 672424751 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 51, largest_acked: 8, rate_sample: RateSample { delivery_rate: 93482, is_app_limited: true, interval: 33.0329ms, delivered: 3088, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 565131, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674489688 }, max_datagram_size: 1350, last_packet_size: None, iv: 237.113µs, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.274009230Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.274013468Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.274091734Z TRACE quiche_apps::client] got 149 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.274101162Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=128 pn=5 [2025-04-30T11:28:38.274107043Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=16 off=0 len=32 fin=true [2025-04-30T11:28:38.274110629Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=20 off=0 len=32 fin=true [2025-04-30T11:28:38.274113445Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=24 off=0 len=32 fin=true [2025-04-30T11:28:38.274120398Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 149 bytes [2025-04-30T11:28:38.274123974Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.274126309Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.274131268Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.274133612Z TRACE quiche_apps::common] stream 16 has 32 bytes (fin? true) [2025-04-30T11:28:38.274135987Z DEBUG quiche_apps::common] 4/39 responses received [2025-04-30T11:28:38.274139223Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.274141377Z TRACE quiche_apps::common] stream 20 has 32 bytes (fin? true) [2025-04-30T11:28:38.274143591Z DEBUG quiche_apps::common] 5/39 responses received [2025-04-30T11:28:38.274146657Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.274148781Z TRACE quiche_apps::common] stream 24 has 32 bytes (fin? true) [2025-04-30T11:28:38.274150925Z DEBUG quiche_apps::common] 6/39 responses received [2025-04-30T11:28:38.274157176Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=2924 out_len=1350 left=1318 [2025-04-30T11:28:38.274160362Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=52 [2025-04-30T11:28:38.274162777Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=7 blocks=[2..5] ecn_counts=None [2025-04-30T11:28:38.274168828Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=70.441793ms latest_rtt=32.470448ms srtt=32.846329ms min_rtt=31.969924ms rttvar=9.597204ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=11926 app_limited=true congestion_recovery_start_time=None Rate { delivered: 3088, delivered_time: Instant { tv_sec: 392, tv_nsec: 672424751 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 9, last_sent_packet: 52, largest_acked: 8, rate_sample: RateSample { delivery_rate: 93482, is_app_limited: true, interval: 33.0329ms, delivered: 3088, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 565131, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.274201579Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.274205337Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.274913970Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.274925912Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=6 [2025-04-30T11:28:38.274931754Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..12] ecn_counts=None [2025-04-30T11:28:38.274935180Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 9 [2025-04-30T11:28:38.274937705Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 10 [2025-04-30T11:28:38.274939939Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 11 [2025-04-30T11:28:38.274942033Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 12 [2025-04-30T11:28:38.274945419Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16779594 [2025-04-30T11:28:38.274956881Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.274960577Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.274962952Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.274969634Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=4124 out_len=1350 left=1318 [2025-04-30T11:28:38.274972750Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=53 [2025-04-30T11:28:38.274975135Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[2..6] ecn_counts=None [2025-04-30T11:28:38.274980785Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=60.56127ms latest_rtt=33.316258ms srtt=32.905069ms min_rtt=31.969924ms rttvar=7.315385ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=10726 app_limited=true congestion_recovery_start_time=None Rate { delivered: 4288, delivered_time: Instant { tv_sec: 392, tv_nsec: 673436952 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 0, last_sent_packet: 53, largest_acked: 12, rate_sample: RateSample { delivery_rate: 129809, is_app_limited: true, interval: 33.0329ms, delivered: 4288, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 564122, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.275019006Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.275025799Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.275097102Z TRACE quiche_apps::client] got 149 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.275106109Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=128 pn=7 [2025-04-30T11:28:38.275114074Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=32 off=0 len=32 fin=true [2025-04-30T11:28:38.275119224Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=36 off=0 len=32 fin=true [2025-04-30T11:28:38.275122460Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=40 off=0 len=32 fin=true [2025-04-30T11:28:38.275136576Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 149 bytes [2025-04-30T11:28:38.275140564Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.275142968Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.275147777Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.275150202Z TRACE quiche_apps::common] stream 32 has 32 bytes (fin? true) [2025-04-30T11:28:38.275152476Z DEBUG quiche_apps::common] 7/39 responses received [2025-04-30T11:28:38.275157415Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.275161262Z TRACE quiche_apps::common] stream 36 has 32 bytes (fin? true) [2025-04-30T11:28:38.275164889Z DEBUG quiche_apps::common] 8/39 responses received [2025-04-30T11:28:38.275170389Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.275173916Z TRACE quiche_apps::common] stream 40 has 32 bytes (fin? true) [2025-04-30T11:28:38.275177302Z DEBUG quiche_apps::common] 9/39 responses received [2025-04-30T11:28:38.275187100Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=4124 out_len=1350 left=1318 [2025-04-30T11:28:38.275190667Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=54 [2025-04-30T11:28:38.275193132Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=10 blocks=[2..7] ecn_counts=None [2025-04-30T11:28:38.275199915Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=60.342111ms latest_rtt=33.316258ms srtt=32.905069ms min_rtt=31.969924ms rttvar=7.315385ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=10726 app_limited=true congestion_recovery_start_time=None Rate { delivered: 4288, delivered_time: Instant { tv_sec: 392, tv_nsec: 673436952 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 0, last_sent_packet: 54, largest_acked: 12, rate_sample: RateSample { delivery_rate: 129809, is_app_limited: true, interval: 33.0329ms, delivered: 4288, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 564122, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.275233527Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.275237414Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.275854558Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.275865007Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=8 [2025-04-30T11:28:38.275870597Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..16] ecn_counts=None [2025-04-30T11:28:38.275873944Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 13 [2025-04-30T11:28:38.275876318Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 14 [2025-04-30T11:28:38.275878512Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 15 [2025-04-30T11:28:38.275880636Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 16 [2025-04-30T11:28:38.275884113Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16780526 [2025-04-30T11:28:38.275900744Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.275904461Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.275906835Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.275913357Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=5324 out_len=1350 left=1318 [2025-04-30T11:28:38.275916583Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=55 [2025-04-30T11:28:38.275919028Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=6 blocks=[2..8] ecn_counts=None [2025-04-30T11:28:38.275924468Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=53.664144ms latest_rtt=34.115663ms srtt=33.056392ms min_rtt=31.969924ms rttvar=5.789186ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=9526 app_limited=true congestion_recovery_start_time=None Rate { delivered: 5488, delivered_time: Instant { tv_sec: 392, tv_nsec: 674376167 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 0, last_sent_packet: 55, largest_acked: 16, rate_sample: RateSample { delivery_rate: 166137, is_app_limited: true, interval: 33.0329ms, delivered: 5488, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 561540, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.275957911Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.275961748Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.276036818Z TRACE quiche_apps::client] got 149 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.276045915Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=128 pn=9 [2025-04-30T11:28:38.276054451Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=48 off=0 len=32 fin=true [2025-04-30T11:28:38.276058939Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=52 off=0 len=32 fin=true [2025-04-30T11:28:38.276061835Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=56 off=0 len=32 fin=true [2025-04-30T11:28:38.276068808Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 149 bytes [2025-04-30T11:28:38.276072434Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.276074769Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.276079518Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.276081762Z TRACE quiche_apps::common] stream 48 has 32 bytes (fin? true) [2025-04-30T11:28:38.276084006Z DEBUG quiche_apps::common] 10/39 responses received [2025-04-30T11:28:38.276087112Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.276089256Z TRACE quiche_apps::common] stream 52 has 32 bytes (fin? true) [2025-04-30T11:28:38.276091420Z DEBUG quiche_apps::common] 11/39 responses received [2025-04-30T11:28:38.276094335Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.276096479Z TRACE quiche_apps::common] stream 56 has 32 bytes (fin? true) [2025-04-30T11:28:38.276098723Z DEBUG quiche_apps::common] 12/39 responses received [2025-04-30T11:28:38.276105086Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=5324 out_len=1350 left=1318 [2025-04-30T11:28:38.276113481Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=56 [2025-04-30T11:28:38.276115926Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=7 blocks=[2..9] ecn_counts=None [2025-04-30T11:28:38.276132577Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=53.455895ms latest_rtt=34.115663ms srtt=33.056392ms min_rtt=31.969924ms rttvar=5.789186ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=9526 app_limited=true congestion_recovery_start_time=None Rate { delivered: 5488, delivered_time: Instant { tv_sec: 392, tv_nsec: 674376167 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 0, last_sent_packet: 56, largest_acked: 16, rate_sample: RateSample { delivery_rate: 166137, is_app_limited: true, interval: 33.0329ms, delivered: 5488, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 561540, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.276166420Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.276170478Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.276876887Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.276887066Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=10 [2025-04-30T11:28:38.276892697Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..20] ecn_counts=None [2025-04-30T11:28:38.276896023Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 17 [2025-04-30T11:28:38.276898508Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 18 [2025-04-30T11:28:38.276900682Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 19 [2025-04-30T11:28:38.276902826Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 20 [2025-04-30T11:28:38.276906192Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16781458 [2025-04-30T11:28:38.276917333Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.276920930Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.276923254Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.276929686Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=6524 out_len=1350 left=1318 [2025-04-30T11:28:38.276932872Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=57 [2025-04-30T11:28:38.276935256Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[2..10] ecn_counts=None [2025-04-30T11:28:38.276940576Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=49.051486ms latest_rtt=35.005404ms srtt=33.300018ms min_rtt=31.969924ms rttvar=4.829142ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=8326 app_limited=true congestion_recovery_start_time=None Rate { delivered: 6688, delivered_time: Instant { tv_sec: 392, tv_nsec: 675398346 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 0, last_sent_packet: 57, largest_acked: 20, rate_sample: RateSample { delivery_rate: 202464, is_app_limited: true, interval: 33.0329ms, delivered: 6688, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 557432, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.276983266Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.276990389Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.277039521Z TRACE quiche_apps::client] got 152 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.277048268Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=131 pn=11 [2025-04-30T11:28:38.277056463Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=64 off=0 len=32 fin=true [2025-04-30T11:28:38.277061462Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=68 off=0 len=32 fin=true [2025-04-30T11:28:38.277064448Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=72 off=0 len=32 fin=true [2025-04-30T11:28:38.277071491Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 152 bytes [2025-04-30T11:28:38.277075198Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.277077542Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.277082341Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.277084555Z TRACE quiche_apps::common] stream 64 has 32 bytes (fin? true) [2025-04-30T11:28:38.277086869Z DEBUG quiche_apps::common] 13/39 responses received [2025-04-30T11:28:38.277090086Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.277092260Z TRACE quiche_apps::common] stream 68 has 32 bytes (fin? true) [2025-04-30T11:28:38.277094434Z DEBUG quiche_apps::common] 14/39 responses received [2025-04-30T11:28:38.277097780Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.277099904Z TRACE quiche_apps::common] stream 72 has 32 bytes (fin? true) [2025-04-30T11:28:38.277102068Z DEBUG quiche_apps::common] 15/39 responses received [2025-04-30T11:28:38.277108500Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=6524 out_len=1350 left=1318 [2025-04-30T11:28:38.277111676Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=58 [2025-04-30T11:28:38.277114070Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=7 blocks=[2..11] ecn_counts=None [2025-04-30T11:28:38.277120162Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=48.87186ms latest_rtt=35.005404ms srtt=33.300018ms min_rtt=31.969924ms rttvar=4.829142ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=8326 app_limited=true congestion_recovery_start_time=None Rate { delivered: 6688, delivered_time: Instant { tv_sec: 392, tv_nsec: 675398346 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 0, last_sent_packet: 58, largest_acked: 20, rate_sample: RateSample { delivery_rate: 202464, is_app_limited: true, interval: 33.0329ms, delivered: 6688, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 557432, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.277158293Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.277162290Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.277870624Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.277880943Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=12 [2025-04-30T11:28:38.277886413Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..24] ecn_counts=None [2025-04-30T11:28:38.277889780Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 21 [2025-04-30T11:28:38.277892194Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 22 [2025-04-30T11:28:38.277894358Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 23 [2025-04-30T11:28:38.277896532Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 24 [2025-04-30T11:28:38.277899948Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16782386 [2025-04-30T11:28:38.277911330Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.277914927Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.277917221Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.277923443Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=7724 out_len=1350 left=1318 [2025-04-30T11:28:38.277926648Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=59 [2025-04-30T11:28:38.277929033Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[2..12] ecn_counts=None [2025-04-30T11:28:38.277934313Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=46.109923ms latest_rtt=35.861193ms srtt=33.620164ms min_rtt=31.969924ms rttvar=4.262149ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=7126 app_limited=true congestion_recovery_start_time=None Rate { delivered: 7888, delivered_time: Instant { tv_sec: 392, tv_nsec: 676392223 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 58, last_sent_packet: 59, largest_acked: 24, rate_sample: RateSample { delivery_rate: 238792, is_app_limited: true, interval: 33.0329ms, delivered: 7888, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 552124, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.277966944Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.277970841Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.278044128Z TRACE quiche_apps::client] got 152 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.278053034Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=131 pn=13 [2025-04-30T11:28:38.278061430Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=80 off=0 len=32 fin=true [2025-04-30T11:28:38.278066099Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=84 off=0 len=32 fin=true [2025-04-30T11:28:38.278068744Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=88 off=0 len=32 fin=true [2025-04-30T11:28:38.278075777Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 152 bytes [2025-04-30T11:28:38.278079384Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.278081708Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.278086467Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.278088671Z TRACE quiche_apps::common] stream 80 has 32 bytes (fin? true) [2025-04-30T11:28:38.278090895Z DEBUG quiche_apps::common] 16/39 responses received [2025-04-30T11:28:38.278093991Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.278096135Z TRACE quiche_apps::common] stream 84 has 32 bytes (fin? true) [2025-04-30T11:28:38.278098319Z DEBUG quiche_apps::common] 17/39 responses received [2025-04-30T11:28:38.278101485Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.278103629Z TRACE quiche_apps::common] stream 88 has 32 bytes (fin? true) [2025-04-30T11:28:38.278105763Z DEBUG quiche_apps::common] 18/39 responses received [2025-04-30T11:28:38.278112155Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=7724 out_len=1350 left=1318 [2025-04-30T11:28:38.278115301Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=60 [2025-04-30T11:28:38.278117705Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=7 blocks=[2..13] ecn_counts=None [2025-04-30T11:28:38.278123847Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=45.920329ms latest_rtt=35.861193ms srtt=33.620164ms min_rtt=31.969924ms rttvar=4.262149ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=7126 app_limited=true congestion_recovery_start_time=None Rate { delivered: 7888, delivered_time: Instant { tv_sec: 392, tv_nsec: 676392223 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 58, last_sent_packet: 60, largest_acked: 24, rate_sample: RateSample { delivery_rate: 238792, is_app_limited: true, interval: 33.0329ms, delivered: 7888, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 552124, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.278156658Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.278160455Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.278804779Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.278814627Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=14 [2025-04-30T11:28:38.278828563Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..28] ecn_counts=None [2025-04-30T11:28:38.278832090Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 25 [2025-04-30T11:28:38.278834464Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 26 [2025-04-30T11:28:38.278836649Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 27 [2025-04-30T11:28:38.278838822Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 28 [2025-04-30T11:28:38.278842149Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16783314 [2025-04-30T11:28:38.278853119Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.278856736Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.278859120Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.278865512Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=8924 out_len=1350 left=1318 [2025-04-30T11:28:38.278868678Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=61 [2025-04-30T11:28:38.278871043Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=6 blocks=[2..14] ecn_counts=None [2025-04-30T11:28:38.278876393Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=44.310827ms latest_rtt=36.646961ms srtt=33.998513ms min_rtt=31.969924ms rttvar=3.95331ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=5926 app_limited=true congestion_recovery_start_time=None Rate { delivered: 9088, delivered_time: Instant { tv_sec: 392, tv_nsec: 677325947 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 60, last_sent_packet: 61, largest_acked: 28, rate_sample: RateSample { delivery_rate: 275119, is_app_limited: true, interval: 33.0329ms, delivered: 9088, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 545979, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.278912801Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.278919673Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.278970819Z TRACE quiche_apps::client] got 152 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.278979605Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=131 pn=15 [2025-04-30T11:28:38.278987751Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=96 off=0 len=32 fin=true [2025-04-30T11:28:38.278992039Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=100 off=0 len=32 fin=true [2025-04-30T11:28:38.278994714Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=104 off=0 len=32 fin=true [2025-04-30T11:28:38.279001537Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 152 bytes [2025-04-30T11:28:38.279005113Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.279007417Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.279012116Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.279019279Z TRACE quiche_apps::common] stream 96 has 32 bytes (fin? true) [2025-04-30T11:28:38.279021744Z DEBUG quiche_apps::common] 19/39 responses received [2025-04-30T11:28:38.279024990Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.279027134Z TRACE quiche_apps::common] stream 100 has 32 bytes (fin? true) [2025-04-30T11:28:38.279029348Z DEBUG quiche_apps::common] 20/39 responses received [2025-04-30T11:28:38.279032414Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.279034528Z TRACE quiche_apps::common] stream 104 has 32 bytes (fin? true) [2025-04-30T11:28:38.279036702Z DEBUG quiche_apps::common] 21/39 responses received [2025-04-30T11:28:38.279043274Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=8924 out_len=1350 left=1318 [2025-04-30T11:28:38.279046370Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=62 [2025-04-30T11:28:38.279048745Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=8 blocks=[2..15] ecn_counts=None [2025-04-30T11:28:38.279054906Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=44.132283ms latest_rtt=36.646961ms srtt=33.998513ms min_rtt=31.969924ms rttvar=3.95331ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=5926 app_limited=true congestion_recovery_start_time=None Rate { delivered: 9088, delivered_time: Instant { tv_sec: 392, tv_nsec: 677325947 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 60, last_sent_packet: 62, largest_acked: 28, rate_sample: RateSample { delivery_rate: 275119, is_app_limited: true, interval: 33.0329ms, delivered: 9088, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 545979, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.279088369Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.279092166Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.279821919Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.279832308Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=16 [2025-04-30T11:28:38.279838019Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..32] ecn_counts=None [2025-04-30T11:28:38.279841636Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 29 [2025-04-30T11:28:38.279844100Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 30 [2025-04-30T11:28:38.279846264Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 31 [2025-04-30T11:28:38.279848388Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 32 [2025-04-30T11:28:38.279851805Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16784242 [2025-04-30T11:28:38.279862835Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.279866512Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.279868837Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.279875299Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10124 out_len=1350 left=1318 [2025-04-30T11:28:38.279883674Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=63 [2025-04-30T11:28:38.279886259Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[2..16] ecn_counts=None [2025-04-30T11:28:38.279901357Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=43.31269ms latest_rtt=37.536472ms srtt=34.440757ms min_rtt=31.969924ms rttvar=3.849471ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=4726 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10288, delivered_time: Instant { tv_sec: 392, tv_nsec: 678343628 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 62, last_sent_packet: 63, largest_acked: 32, rate_sample: RateSample { delivery_rate: 311447, is_app_limited: true, interval: 33.0329ms, delivered: 10288, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 538968, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.279946462Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.279953715Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.279967180Z TRACE quiche_apps::client] got 152 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.279973201Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=131 pn=17 [2025-04-30T11:28:38.279981267Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=112 off=0 len=32 fin=true [2025-04-30T11:28:38.279986727Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=116 off=0 len=32 fin=true [2025-04-30T11:28:38.279991225Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=120 off=0 len=32 fin=true [2025-04-30T11:28:38.280000793Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 152 bytes [2025-04-30T11:28:38.280005101Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.280007465Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.280012265Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.280014489Z TRACE quiche_apps::common] stream 112 has 32 bytes (fin? true) [2025-04-30T11:28:38.280016793Z DEBUG quiche_apps::common] 22/39 responses received [2025-04-30T11:28:38.280019939Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.280022123Z TRACE quiche_apps::common] stream 116 has 32 bytes (fin? true) [2025-04-30T11:28:38.280024337Z DEBUG quiche_apps::common] 23/39 responses received [2025-04-30T11:28:38.280027253Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.280029397Z TRACE quiche_apps::common] stream 120 has 32 bytes (fin? true) [2025-04-30T11:28:38.280031681Z DEBUG quiche_apps::common] 24/39 responses received [2025-04-30T11:28:38.280038163Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10124 out_len=1350 left=1318 [2025-04-30T11:28:38.280041419Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=64 [2025-04-30T11:28:38.280043844Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=8 blocks=[2..17] ecn_counts=None [2025-04-30T11:28:38.280058761Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=43.154915ms latest_rtt=37.536472ms srtt=34.440757ms min_rtt=31.969924ms rttvar=3.849471ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=4726 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10288, delivered_time: Instant { tv_sec: 392, tv_nsec: 678343628 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 62, last_sent_packet: 64, largest_acked: 32, rate_sample: RateSample { delivery_rate: 311447, is_app_limited: true, interval: 33.0329ms, delivered: 10288, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 538968, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.280100179Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.280104727Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.280784958Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.280795448Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=18 [2025-04-30T11:28:38.280801138Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..36] ecn_counts=None [2025-04-30T11:28:38.280804575Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 33 [2025-04-30T11:28:38.280807069Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 34 [2025-04-30T11:28:38.280809203Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 35 [2025-04-30T11:28:38.280811327Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 36 [2025-04-30T11:28:38.280814664Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16785170 [2025-04-30T11:28:38.280826145Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.280829742Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.280832076Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.280838418Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11324 out_len=1350 left=1318 [2025-04-30T11:28:38.280841604Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=65 [2025-04-30T11:28:38.280844008Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[2..18] ecn_counts=None [2025-04-30T11:28:38.280849469Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=42.92688ms latest_rtt=38.362325ms srtt=34.930952ms min_rtt=31.969924ms rttvar=3.867495ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=3526 app_limited=true congestion_recovery_start_time=None Rate { delivered: 11488, delivered_time: Instant { tv_sec: 392, tv_nsec: 679306557 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 64, last_sent_packet: 65, largest_acked: 36, rate_sample: RateSample { delivery_rate: 347774, is_app_limited: true, interval: 33.0329ms, delivered: 11488, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 531405, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.280887981Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.280891988Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.280974011Z TRACE quiche_apps::client] got 152 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.280981215Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=131 pn=19 [2025-04-30T11:28:38.280986775Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=128 off=0 len=32 fin=true [2025-04-30T11:28:38.280990101Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=132 off=0 len=32 fin=true [2025-04-30T11:28:38.280992716Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=136 off=0 len=32 fin=true [2025-04-30T11:28:38.281010870Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 152 bytes [2025-04-30T11:28:38.281014306Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.281016621Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.281021420Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.281023704Z TRACE quiche_apps::common] stream 128 has 32 bytes (fin? true) [2025-04-30T11:28:38.281026108Z DEBUG quiche_apps::common] 25/39 responses received [2025-04-30T11:28:38.281029334Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.281031509Z TRACE quiche_apps::common] stream 132 has 32 bytes (fin? true) [2025-04-30T11:28:38.281033823Z DEBUG quiche_apps::common] 26/39 responses received [2025-04-30T11:28:38.281036889Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.281039043Z TRACE quiche_apps::common] stream 136 has 32 bytes (fin? true) [2025-04-30T11:28:38.281041417Z DEBUG quiche_apps::common] 27/39 responses received [2025-04-30T11:28:38.281047619Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11324 out_len=1350 left=1318 [2025-04-30T11:28:38.281050795Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=66 [2025-04-30T11:28:38.281053199Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=8 blocks=[2..19] ecn_counts=None [2025-04-30T11:28:38.281059140Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=42.717228ms latest_rtt=38.362325ms srtt=34.930952ms min_rtt=31.969924ms rttvar=3.867495ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=3526 app_limited=true congestion_recovery_start_time=None Rate { delivered: 11488, delivered_time: Instant { tv_sec: 392, tv_nsec: 679306557 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 64, last_sent_packet: 66, largest_acked: 36, rate_sample: RateSample { delivery_rate: 347774, is_app_limited: true, interval: 33.0329ms, delivered: 11488, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 531405, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.281096190Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.281100047Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.281683737Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.281693866Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=20 [2025-04-30T11:28:38.281699497Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..40] ecn_counts=None [2025-04-30T11:28:38.281702893Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 37 [2025-04-30T11:28:38.281705348Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 38 [2025-04-30T11:28:38.281707532Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 39 [2025-04-30T11:28:38.281709625Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 40 [2025-04-30T11:28:38.281712982Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16786098 [2025-04-30T11:28:38.281724413Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.281728010Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.281730334Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.281736556Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12463 out_len=1350 left=1318 [2025-04-30T11:28:38.281739681Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=67 [2025-04-30T11:28:38.281742106Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[2..20] ecn_counts=None [2025-04-30T11:28:38.281747426Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=42.8508ms latest_rtt=39.099242ms srtt=35.451988ms min_rtt=31.969924ms rttvar=3.942693ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=2387 app_limited=true congestion_recovery_start_time=None Rate { delivered: 12627, delivered_time: Instant { tv_sec: 392, tv_nsec: 680205216 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 66, last_sent_packet: 67, largest_acked: 40, rate_sample: RateSample { delivery_rate: 382255, is_app_limited: true, interval: 33.0329ms, delivered: 12627, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 523595, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.281779947Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.281783614Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.281864525Z TRACE quiche_apps::client] got 188 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.281871879Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=167 pn=21 [2025-04-30T11:28:38.281882789Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=144 off=0 len=32 fin=true [2025-04-30T11:28:38.281886165Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=148 off=0 len=32 fin=true [2025-04-30T11:28:38.281888931Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=152 off=0 len=32 fin=true [2025-04-30T11:28:38.281891616Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=12 off=0 len=32 fin=true [2025-04-30T11:28:38.281898779Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 188 bytes [2025-04-30T11:28:38.281902365Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.281904710Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.281909479Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.281911703Z TRACE quiche_apps::common] stream 144 has 32 bytes (fin? true) [2025-04-30T11:28:38.281914067Z DEBUG quiche_apps::common] 28/39 responses received [2025-04-30T11:28:38.281917825Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.281919998Z TRACE quiche_apps::common] stream 148 has 32 bytes (fin? true) [2025-04-30T11:28:38.281922223Z DEBUG quiche_apps::common] 29/39 responses received [2025-04-30T11:28:38.281925339Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.281927503Z TRACE quiche_apps::common] stream 152 has 32 bytes (fin? true) [2025-04-30T11:28:38.281929787Z DEBUG quiche_apps::common] 30/39 responses received [2025-04-30T11:28:38.281932833Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.281934986Z TRACE quiche_apps::common] stream 12 has 32 bytes (fin? true) [2025-04-30T11:28:38.281937130Z DEBUG quiche_apps::common] 31/39 responses received [2025-04-30T11:28:38.281943442Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12463 out_len=1350 left=1318 [2025-04-30T11:28:38.281946598Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=68 [2025-04-30T11:28:38.281948993Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=9 blocks=[2..21] ecn_counts=None [2025-04-30T11:28:38.281955124Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=42.643042ms latest_rtt=39.099242ms srtt=35.451988ms min_rtt=31.969924ms rttvar=3.942693ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=2387 app_limited=true congestion_recovery_start_time=None Rate { delivered: 12627, delivered_time: Instant { tv_sec: 392, tv_nsec: 680205216 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 66, last_sent_packet: 68, largest_acked: 40, rate_sample: RateSample { delivery_rate: 382255, is_app_limited: true, interval: 33.0329ms, delivered: 12627, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 523595, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.281987615Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.281991231Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.282351264Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.282358448Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=22 [2025-04-30T11:28:38.282368927Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[1..45] ecn_counts=None [2025-04-30T11:28:38.282372394Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 41 [2025-04-30T11:28:38.282374758Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 42 [2025-04-30T11:28:38.282376912Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 43 [2025-04-30T11:28:38.282379006Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 44 [2025-04-30T11:28:38.282382262Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 45 [2025-04-30T11:28:38.282387652Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16786643 [2025-04-30T11:28:38.282399534Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.282403161Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.282405496Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.282411988Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=13293 out_len=1350 left=1318 [2025-04-30T11:28:38.282415114Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=69 [2025-04-30T11:28:38.282417488Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=6 blocks=[2..22] ecn_counts=None [2025-04-30T11:28:38.282422848Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=42.917865ms latest_rtt=39.616598ms srtt=35.972563ms min_rtt=31.969924ms rttvar=3.998171ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=1557 app_limited=true congestion_recovery_start_time=None Rate { delivered: 13457, delivered_time: Instant { tv_sec: 392, tv_nsec: 680869717 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 68, last_sent_packet: 69, largest_acked: 45, rate_sample: RateSample { delivery_rate: 407381, is_app_limited: true, interval: 33.0329ms, delivered: 13457, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 516018, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.282455649Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.282459356Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.282649461Z TRACE quiche_apps::client] got 223 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.282659600Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=202 pn=23 [2025-04-30T11:28:38.282665451Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=28 off=0 len=32 fin=true [2025-04-30T11:28:38.282668767Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=44 off=0 len=32 fin=true [2025-04-30T11:28:38.282671362Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=60 off=0 len=32 fin=true [2025-04-30T11:28:38.282674037Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=76 off=0 len=32 fin=true [2025-04-30T11:28:38.282682062Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=92 off=0 len=32 fin=true [2025-04-30T11:28:38.282689877Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 223 bytes [2025-04-30T11:28:38.282693423Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.282695768Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.282700496Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.282702741Z TRACE quiche_apps::common] stream 28 has 32 bytes (fin? true) [2025-04-30T11:28:38.282705005Z DEBUG quiche_apps::common] 32/39 responses received [2025-04-30T11:28:38.282717448Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.282719702Z TRACE quiche_apps::common] stream 44 has 32 bytes (fin? true) [2025-04-30T11:28:38.282721867Z DEBUG quiche_apps::common] 33/39 responses received [2025-04-30T11:28:38.282725102Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.282727257Z TRACE quiche_apps::common] stream 60 has 32 bytes (fin? true) [2025-04-30T11:28:38.282729511Z DEBUG quiche_apps::common] 34/39 responses received [2025-04-30T11:28:38.282732546Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.282734700Z TRACE quiche_apps::common] stream 76 has 32 bytes (fin? true) [2025-04-30T11:28:38.282736864Z DEBUG quiche_apps::common] 35/39 responses received [2025-04-30T11:28:38.282739900Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.282742064Z TRACE quiche_apps::common] stream 92 has 32 bytes (fin? true) [2025-04-30T11:28:38.282744328Z DEBUG quiche_apps::common] 36/39 responses received [2025-04-30T11:28:38.282750850Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=13293 out_len=1350 left=1318 [2025-04-30T11:28:38.282754056Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=70 [2025-04-30T11:28:38.282756531Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=11 blocks=[2..23] ecn_counts=None [2025-04-30T11:28:38.282762953Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=42.57771ms latest_rtt=39.616598ms srtt=35.972563ms min_rtt=31.969924ms rttvar=3.998171ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=1557 app_limited=true congestion_recovery_start_time=None Rate { delivered: 13457, delivered_time: Instant { tv_sec: 392, tv_nsec: 680869717 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 638474488 }, end_of_app_limited: 68, last_sent_packet: 70, largest_acked: 45, rate_sample: RateSample { delivery_rate: 407381, is_app_limited: true, interval: 33.0329ms, delivered: 13457, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 638474488 }), send_elapsed: 0ns, ack_elapsed: 33.0329ms, rtt: 33.0329ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 516018, last_update: Instant { tv_sec: 392, tv_nsec: 672467691 }, next_time: Instant { tv_sec: 392, tv_nsec: 674726801 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.282795785Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.282799622Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.306088147Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.306102664Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=1199 pn=24 [2025-04-30T11:28:38.306111421Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[5..45, 48..48] ecn_counts=None [2025-04-30T11:28:38.306123754Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 48 [2025-04-30T11:28:38.306128943Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm HANDSHAKE_DONE [2025-04-30T11:28:38.306133472Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a dropped epoch 1 state [2025-04-30T11:28:38.306136608Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_STREAMS type=bidi max=103 [2025-04-30T11:28:38.306142288Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[c3, 02, 4e, be, 13, 51, 70, 7c, 83] reset_token=[ff, 87, 21, 6c, d9, e3, ed, 00, ed, ce, 84, d5, 57, 10, 98, d7] [2025-04-30T11:28:38.306150754Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[c3, 02, 89, f8, 07, 0d, b4, 8a, 57] reset_token=[d4, 40, 96, 32, be, 73, 54, 37, 50, c3, 51, 87, 5c, fd, d5, b8] [2025-04-30T11:28:38.306157346Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c3, 02, 27, 03, 10, e5, 08, 79, 04] reset_token=[d0, ca, bd, e4, 7a, f6, 04, 26, 34, c1, c6, a5, bb, 07, f6, 10] [2025-04-30T11:28:38.306167005Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm PADDING len=1081 [2025-04-30T11:28:38.306182353Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 1220 bytes [2025-04-30T11:28:38.306188995Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.306192753Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.306205386Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=14582 out_len=1350 left=1318 [2025-04-30T11:28:38.306209704Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=71 [2025-04-30T11:28:38.306213031Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=12 blocks=[4..24] ecn_counts=None [2025-04-30T11:28:38.306220545Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=44.428051ms latest_rtt=32.519506ms srtt=35.54093ms min_rtt=31.969924ms rttvar=3.861892ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=268 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14630, delivered_time: Instant { tv_sec: 392, tv_nsec: 704613463 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 672093957 }, end_of_app_limited: 70, last_sent_packet: 71, largest_acked: 48, rate_sample: RateSample { delivery_rate: 379006, is_app_limited: true, interval: 33.619469ms, delivered: 12742, prior_delivered: 1888, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 671782812 }), send_elapsed: 33.619469ms, ack_elapsed: 32.830651ms, rtt: 32.519506ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 522285, last_update: Instant { tv_sec: 392, tv_nsec: 704714422 }, next_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.306266640Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.306271930Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.307074089Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.307081643Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=1199 pn=25 [2025-04-30T11:28:38.307087123Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm PING mtu_probe=None [2025-04-30T11:28:38.307098405Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm PADDING len=1178 [2025-04-30T11:28:38.307104085Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 1220 bytes [2025-04-30T11:28:38.307107562Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.307109896Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.307115577Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=14582 out_len=1350 left=1318 [2025-04-30T11:28:38.307118832Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=72 [2025-04-30T11:28:38.307121197Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=4 blocks=[4..25] ecn_counts=None [2025-04-30T11:28:38.307126827Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=43.521949ms latest_rtt=32.519506ms srtt=35.54093ms min_rtt=31.969924ms rttvar=3.861892ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=268 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14630, delivered_time: Instant { tv_sec: 392, tv_nsec: 704613463 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 672093957 }, end_of_app_limited: 70, last_sent_packet: 72, largest_acked: 48, rate_sample: RateSample { delivery_rate: 379006, is_app_limited: true, interval: 33.619469ms, delivered: 12742, prior_delivered: 1888, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 671782812 }), send_elapsed: 33.619469ms, ack_elapsed: 32.830651ms, rtt: 32.519506ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 522285, last_update: Instant { tv_sec: 392, tv_nsec: 704714422 }, next_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.307158907Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.307162795Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.307388276Z TRACE quiche_apps::client] got 366 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.307393115Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=345 pn=26 [2025-04-30T11:28:38.307398355Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm CRYPTO off=0 len=321 [2025-04-30T11:28:38.307418633Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 366 bytes [2025-04-30T11:28:38.307423622Z TRACE quiche_apps::client] got 78 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.307426728Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=57 pn=27 [2025-04-30T11:28:38.307430866Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=108 off=0 len=32 fin=true [2025-04-30T11:28:38.307435534Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 78 bytes [2025-04-30T11:28:38.307438770Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.307441125Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.307445613Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.307447947Z TRACE quiche_apps::common] stream 108 has 32 bytes (fin? true) [2025-04-30T11:28:38.307450352Z DEBUG quiche_apps::common] 37/39 responses received [2025-04-30T11:28:38.307456403Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=14582 out_len=1350 left=1318 [2025-04-30T11:28:38.307459499Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=73 [2025-04-30T11:28:38.307466682Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=3 blocks=[4..27] ecn_counts=None [2025-04-30T11:28:38.307472553Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=43.176153ms latest_rtt=32.519506ms srtt=35.54093ms min_rtt=31.969924ms rttvar=3.861892ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=268 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14630, delivered_time: Instant { tv_sec: 392, tv_nsec: 704613463 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 672093957 }, end_of_app_limited: 70, last_sent_packet: 73, largest_acked: 48, rate_sample: RateSample { delivery_rate: 379006, is_app_limited: true, interval: 33.619469ms, delivered: 12742, prior_delivered: 1888, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 671782812 }), send_elapsed: 33.619469ms, ack_elapsed: 32.830651ms, rtt: 32.519506ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 522285, last_update: Instant { tv_sec: 392, tv_nsec: 704714422 }, next_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.307522737Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.307530101Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.307553094Z TRACE quiche_apps::client] got 56 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.307557332Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=35 pn=28 [2025-04-30T11:28:38.307562732Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[13..45, 48..53] ecn_counts=None [2025-04-30T11:28:38.307566168Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 49 [2025-04-30T11:28:38.307568583Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 50 [2025-04-30T11:28:38.307570747Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 51 [2025-04-30T11:28:38.307572861Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 52 [2025-04-30T11:28:38.307574955Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 53 [2025-04-30T11:28:38.307578842Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_DATA max=16787239 [2025-04-30T11:28:38.307581487Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_STREAMS type=bidi max=106 [2025-04-30T11:28:38.307591666Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 56 bytes [2025-04-30T11:28:38.307595222Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.307597617Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.307603458Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=14850 out_len=1350 left=1318 [2025-04-30T11:28:38.307606524Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=5 pn=74 [2025-04-30T11:28:38.307608848Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm ACK delay=5 blocks=[7..28] ecn_counts=None [2025-04-30T11:28:38.307614068Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=none latest_rtt=31.342031ms srtt=35.016066ms min_rtt=31.342031ms rttvar=3.946143ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14898, delivered_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, end_of_app_limited: 73, last_sent_packet: 74, largest_acked: 53, rate_sample: RateSample { delivery_rate: 292670, is_app_limited: false, interval: 36.252313ms, delivered: 10610, prior_delivered: 4288, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 673436952 }), send_elapsed: 36.252313ms, ack_elapsed: 32.63188ms, rtt: 31.342031ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 530113, last_update: Instant { tv_sec: 392, tv_nsec: 704714422 }, next_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.307650877Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.307654754Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.307662268Z TRACE quiche_apps::client] got 125 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.307665724Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=104 pn=29 [2025-04-30T11:28:38.307670573Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[13..45, 48..54] ecn_counts=None [2025-04-30T11:28:38.307673649Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 54 [2025-04-30T11:28:38.307676514Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_STREAMS type=bidi max=109 [2025-04-30T11:28:38.307679199Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=124 off=0 len=32 fin=true [2025-04-30T11:28:38.307682305Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm STREAM id=140 off=0 len=32 fin=true [2025-04-30T11:28:38.307688697Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 125 bytes [2025-04-30T11:28:38.307692915Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.307695770Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx pkt Short dcid=3d6ae1b6cbb911121742c0f8f9f0c34056461f1a key_phase=false len=30 pn=30 [2025-04-30T11:28:38.307699517Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm ACK delay=0 blocks=[17..45, 48..56] ecn_counts=None [2025-04-30T11:28:38.307702233Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 55 [2025-04-30T11:28:38.307704437Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a packet newly acked 56 [2025-04-30T11:28:38.307706931Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a rx frm MAX_STREAMS type=bidi max=112 [2025-04-30T11:28:38.307710889Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.307714084Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.307716419Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.307720727Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.307722951Z TRACE quiche_apps::common] stream 124 has 32 bytes (fin? true) [2025-04-30T11:28:38.307725285Z DEBUG quiche_apps::common] 38/39 responses received [2025-04-30T11:28:38.307728572Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T11:28:38.307730736Z TRACE quiche_apps::common] stream 140 has 32 bytes (fin? true) [2025-04-30T11:28:38.307733070Z DEBUG quiche_apps::common] 39/39 responses received [2025-04-30T11:28:38.307735374Z INFO quiche_apps::common] 39/39 response(s) received in 67.586389ms, closing... [2025-04-30T11:28:38.307745333Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=14850 out_len=1350 left=1323 [2025-04-30T11:28:38.307748529Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx pkt Short dcid=c3022cd912673a0021 key_phase=false len=10 pn=75 [2025-04-30T11:28:38.307750883Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a tx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65] [2025-04-30T11:28:38.307757055Z TRACE quiche::recovery::congestion::recovery] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a timer=76.786682ms latest_rtt=31.342031ms srtt=35.016066ms min_rtt=31.342031ms rttvar=3.946143ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=37 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14898, delivered_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, first_sent_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, end_of_app_limited: 74, last_sent_packet: 75, largest_acked: 56, rate_sample: RateSample { delivery_rate: 259569, is_app_limited: false, interval: 36.252313ms, delivered: 9410, prior_delivered: 5488, prior_time: Some(Instant { tv_sec: 392, tv_nsec: 674376167 }), send_elapsed: 36.252313ms, ack_elapsed: 31.831835ms, rtt: 31.481201ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 530113, last_update: Instant { tv_sec: 392, tv_nsec: 706255992 }, next_time: Instant { tv_sec: 392, tv_nsec: 704714422 }, max_datagram_size: 1350, last_packet_size: None, iv: 69.796µs, max_pacing_rate: None } hystart=window_end=Some(47) last_round_min_rtt=31.969924ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T11:28:38.307787332Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:33241 to 193.167.100.100:443 [2025-04-30T11:28:38.307790758Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.307797991Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.307800947Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.307804033Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.307806337Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.307809453Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.308529688Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.308536110Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.308539276Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.308541590Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.308544646Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.309454446Z TRACE quiche_apps::client] got 51 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.309457772Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 51 bytes [2025-04-30T11:28:38.309460758Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.309463012Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.309466048Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.310472277Z TRACE quiche_apps::client] got 52 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.310477317Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 52 bytes [2025-04-30T11:28:38.310480372Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.310482647Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.310485642Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.311457668Z TRACE quiche_apps::client] got 52 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.311461475Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 52 bytes [2025-04-30T11:28:38.311469110Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.311471514Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.311474650Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.312360174Z TRACE quiche_apps::client] got 52 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.312365765Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 52 bytes [2025-04-30T11:28:38.312368850Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.312371185Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.312374210Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.313157133Z TRACE quiche_apps::client] got 50 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.313160499Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 50 bytes [2025-04-30T11:28:38.313163605Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.313165899Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.313168895Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.338558425Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.338568855Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 1252 bytes [2025-04-30T11:28:38.338574174Z TRACE quiche_apps::client] got 50 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.338577711Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 50 bytes [2025-04-30T11:28:38.338582640Z TRACE quiche_apps::client] got 58 bytes from 193.167.100.100:443 to 0.0.0.0:33241 [2025-04-30T11:28:38.338585916Z TRACE quiche_apps::client] 0.0.0.0:33241: processed 58 bytes [2025-04-30T11:28:38.338589714Z TRACE quiche_apps::client] 0.0.0.0:33241: recv() would block [2025-04-30T11:28:38.338592609Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.338596977Z TRACE quiche_apps::client] 0.0.0.0:33241 -> 193.167.100.100:443: done writing [2025-04-30T11:28:38.460765903Z TRACE quiche_apps::client] timed out [2025-04-30T11:28:38.460779087Z TRACE quiche] 3d6ae1b6cbb911121742c0f8f9f0c34056461f1a draining timeout expired [2025-04-30T11:28:38.460809925Z TRACE quiche_apps::client] done reading [2025-04-30T11:28:38.460814073Z INFO quiche_apps::client] connection closed, recv=31 sent=76 lost=0 retrans=0 sent_bytes=15880 recv_bytes=6664 lost_bytes=0 [local_addr=0.0.0.0:33241 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=31 sent=76 lost=0 retrans=0 rtt=35.016066ms min_rtt=Some(31.342031ms) rttvar=3.946143ms cwnd=14850 sent_bytes=15880 recv_bytes=6664 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=259569]