[2025-04-30T08:43:42.776908409Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T08:43:42.777196085Z INFO quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:50732 with scid 41e1e5aab8a8e0a3e3e742f4e884810812a1512c [2025-04-30T08:43:42.777242752Z TRACE quiche::tls] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c write message lvl=Initial len=528 [2025-04-30T08:43:42.777257460Z TRACE quiche::tls] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c set write secret lvl=ZeroRTT [2025-04-30T08:43:42.777278089Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Initial version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=532 pn=0 [2025-04-30T08:43:42.777281094Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm CRYPTO off=0 len=528 [2025-04-30T08:43:42.777293638Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=998.90876ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=595 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 145328707 }, next_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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-30T08:43:42.777372044Z TRACE quiche_apps::client] written 1200 [2025-04-30T08:43:42.777375871Z TRACE quiche_apps::client] timed out [2025-04-30T08:43:42.777379147Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.777406358Z DEBUG quiche_apps::common] sending HTTP request "GET /jindjmgzeztplldinjdyrkmdrdrszcesrcwcrwkjgcwnzudbppwmycoeudhexunflszwbovdyrptobpihbkevsdenypvygukpzeyalqnyqwnpeazspjgpcxaedocvpkwoevubsjuymlgjimwfvsmejgchiuurvjsdsdmshumaucxeubffotdxklcbhceafsyswkezbcujxbegitkjqawgxtnmgiuizbfswpfphhxqrgrlyuigsrtfvswut\r\n" [2025-04-30T08:43:42.777451973Z DEBUG quiche_apps::common] sending HTTP request "GET /bskqppitqhmedpggzdwacpjnxopdkhcfzgfpcqestkwkthnnlnbzonnjudjpclqrpcvmsuhwaygtelxmyvxgoabqcqkydlrxohlizltognflqlnsbyipqmddpjmlxwlbphujyhotfxtndfmhawapsrqxznfejuuebwgumunxgvwhuutmkilcbuvcsmmaadcnzczdpgrbiophikrngmmreveqacjanqbsusrebzfvzkeknyitquoezhoaex\r\n" [2025-04-30T08:43:42.777488591Z DEBUG quiche_apps::common] sending HTTP request "GET /bzhlrycdqwlxbcvzanfnkbxcxrcmptqjhxxpcxjetgevzpydixlziuvqytvugklyiklvqppdawbvtqqnvjeptmgtqveoirllicpdexcwrjauhykjddtxdwbutrvvmgmjaombfbnxlijjgovcunlcrvepnhhasjrytggfyejqaaowfwezurmghrnijffrqjsnbldjcytaiwgohuvrumdknqkgmemafujdrtijtlfwavupfeuwwxzdlodiqm\r\n" [2025-04-30T08:43:42.777514890Z DEBUG quiche_apps::common] sending HTTP request "GET /zsmgqcbeykvvxhaaxwlpxjymcwddumdkkifnbpjzghvafypdldrnkjjzhsbyqvbbhjlwtscbdzdwnjjbmiavhpmlqpvccxlezabweagzmosdndxpyatsxenfvbwdggnbuxwbsexqtrnwxmuyhukvofhduwcaumvjhdonecrrhzvsaonvwjttrikhmxheltllmqfutkxqztbknqtwsnrlozhfbfihnxpekwjisavopuepnmervnzncljfuy\r\n" [2025-04-30T08:43:42.777538184Z DEBUG quiche_apps::common] sending HTTP request "GET /tpjowwxeapvsadbsalbbmcchkaufkfgdgjtozalxkcggljosfdlnhjmshzrwvjoktljkfabmvzjdrviiukpzeonxebohjbtdnotiwzhrycsgdrldvsarocgxixuxlnaugarpixcudlljiemljcmdxbwwsvrksagunrurptcdjfcasjpjecoeaeslitguditrwktdwhdymdystqotaljrynuqmkprrehmemyjrztdsptozgyaljhkslioov\r\n" [2025-04-30T08:43:42.777560565Z DEBUG quiche_apps::common] sending HTTP request "GET /mxxmfqvexssoxpeagzvizerjclbbsesrmdudsjqwqfilretevrbibzurzovnhtsovebmbglwsfnrkopsmmpjdyadtyrzsdojuumdtggqdamfrgpxclvygqxhtowesiaxhsvfggjuvxkqrgdwfyujnkwgcwlkfxuopuvxbvzmetpuftvnhcunsogybpzdfqmnrriurlarzjtxfjcgbyptuycvnsugmrxpwocnmlcuwcxurgbmmkchdsgqls\r\n" [2025-04-30T08:43:42.777589880Z DEBUG quiche_apps::common] sending HTTP request "GET /mxbscdbuptgfxnpavoppsxgbmkbnjjaejirwyjcavbwxplmtghvhncgvbfojmyblxnqwwzqnudlkpgyltrcbdsucapufmkuzkliryllenunukezqggbqldvqztaixjkpfxxiycsfantyiztshvywlzhucfgdybgvsqdejxvhenurikgdpzxfforayjtvfrrmgmpcayyqqgevlzokxtjauqgieqbdkwvynlxlrwmfufoemljbnlzbzxvrig\r\n" [2025-04-30T08:43:42.777612021Z DEBUG quiche_apps::common] sending HTTP request "GET /ukykzlqpcjpmqjgrfnqimbfutnyhkojyieujsbkhuasbhrgwlblhowqdjptstqeivwxcigdmjiwjhenfwroaxtteykcwdkzvfdiysfihoblomqhzjqtfccthnwsqfreguixxajtnekjylifpknmshacruaqeqnuiodxgwprlmwidjrritozfzqskwmljmnlftejozpnbpykhbnozrartxkieppwpdsmstccqtwoijuioxavpgjoowamzsp\r\n" [2025-04-30T08:43:42.777633652Z DEBUG quiche_apps::common] sending HTTP request "GET /quqlcirucfpryduhtikydqpgdnxmvxlcntfovftkpqqmgslcnzejyisjirpixouqvjcdzqbdlnefjchtvgxykrwzgzcllrdhdmeqaevuiyomfefpfygxbxjdnkfgmoipqhrcpntljfqgigpyutrkxsivuzqqipmffmznivhtllxuovuoanswavfcwuyjgwpcdjqunrskkcvyptwonyoxkbmonqntdninuxkppgzhhurecnzdjtuusudoku\r\n" [2025-04-30T08:43:42.777654480Z DEBUG quiche_apps::common] sending HTTP request "GET /muzdadcbjqfbgjpjtttnpefzdpqdhbjziaoawjdamufpdecnlojykfwqwkzqshtvwuqrvmfwktnbjdfqpeudmevtvorouwhduoocgprstcrtfztaccsuqvyesvoepqwjiaxrssiyrgfjknscrubquqeliknqgqzuspsaxdikkiahzazhtkzkfbdakganestvglrdwybdtontuznwcvbhtbgzqwalkltoxwzdjuelmgaotusgqlxsthfbnk\r\n" [2025-04-30T08:43:42.777676913Z DEBUG quiche_apps::common] sending HTTP request "GET /odfzmaicwszeiijskdmniobadhtvfdltzgymbkojyqzatfixqtxzwhwxpxoqzvxgldvsaworpjbmjezymjqumqeramaebmrxwrbyoiejkiybmeijapvadhewzweccjaxqmxmavrloksvgnmomqdfxmtusmipahqvcztjypsvtmyfgvmivaqypgjndkqepidnagbzcszdkmnhtdpghxbqbzmzflfabpjefmelhmjkbfjwlkxthmhbnlnanp\r\n" [2025-04-30T08:43:42.777698182Z DEBUG quiche_apps::common] sending HTTP request "GET /ncebaogxgjaqezoscjkisgycgcoznjgdqjisiovkxqfffxsdtrsqyomvauyccobfzmynwjqnvggmpbuuwabwtfxgagxvfvnlhjcmhipgzwvnbhnjgezooxelmnqgzcbumkjarliavuebdjumgyhofilewagfhvvyurkjxupxdwfehmmpltrxegcwuwhsvvtdryapdirzudsirethcdbdcymxkfhqyjpfhalzkfxkiumjjkgmcqaexgyote\r\n" [2025-04-30T08:43:42.777719532Z DEBUG quiche_apps::common] sending HTTP request "GET /viyyruoyyvqtprdangmyiszyghbyhkerpkwegzrwyubyehnzyhcoeystawnfcgzvywxpupbaowemkruikzzbcujcfjsvploheckrykuozlkvfhhrhqxmcwqtvnmxggemmmbcxyabdmojjsjzeoqqojpwrwygbyhymdkqpscstjntnepxpmdnvdxyqycpuhqkjixwwjerswtadfuoprkeudvjxzbiximqgrdqzwktoccumzamqbpjhvhhsy\r\n" [2025-04-30T08:43:42.777740842Z DEBUG quiche_apps::common] sending HTTP request "GET /njfgrtbnncalbtnjbrwghswlrmvatqoscrtqfarqspmvlyfizcguqvruofoytgpsytdrtjzpvufdnduddprcrjdejfzlkxrobmxdjrnjghdbvqsrudpirszrnskzxcwdzoluxdbijujjcpnvbqarhhoyzhskbvrhmewlioynxyzewpiwekdgohydatjelgjahoulqoovsybiintdgvfpbvlrjdvpadmjbqbybvwkpvbystlumeoglzfhpi\r\n" [2025-04-30T08:43:42.777762773Z DEBUG quiche_apps::common] sending HTTP request "GET /fgkrxqybpalkbgdvyxhtyacixgoplzjpkddvdqoubzqghxiycsnqiqioeshfeemfhgmodvfydzevwptcxubzdjsjjsuwpbbcpohrwtndbylgkanyiqcmsiguhqtrgtcewakxswomacqdlvhqyptukuapdinmqimevxogsxjjzavtcmofriyvgksjptpztoirkdecbkdekcvltrqadndyknywjzlcgiwgygxzyjubmzyvmlwxccztjvtvqt\r\n" [2025-04-30T08:43:42.777822955Z DEBUG quiche_apps::common] sending HTTP request "GET /minnatqpmyrssvgdqmarxwowbfpguhfwbyqhmjsurndlntsbmbpjgzhaspzclhnejeksigcrtphwlwfotddkyzihjfwpmmlqhjogruefvhoacxvuwhdyslzofitmdolspcszanpxmzkcgeswgrvzcyrenknetwwoaxnamoycguiuhjfmkchndpwgyotzqlfjzohlmqbacpkaeukcxiufufvisdbbthsotnmfrpfwibqhguyclzasigcsea\r\n" [2025-04-30T08:43:42.777851268Z DEBUG quiche_apps::common] sending HTTP request "GET /oepskfssvhntajilzkrnicepwyncpvcsvoibzrrxwqthhwcbcrsyttfqhytspngtegprtkjmuuzjhylykxskprpzzijdhrsxzpqqrgdaoofahpnqlavapbwbijixukhbmbsqcgwtjovdtokoilzrkmuszuiwezwprupoulpnlxrwvnmlykpwgepzlpuzgbjwfhasprspukgxfgcjttervhdkjyjublpdmwyqsydtueiykogymdbbvrjsjn\r\n" [2025-04-30T08:43:42.777891262Z DEBUG quiche_apps::common] sending HTTP request "GET /rfltpwdbyoovepagkawwvzpraoqeuxsqbtloeodgkcvcvapecehqfcvkzlviannjrzcqludqtkjoaldedmsunxyiidqlerzbobeyzmuswxvhefwexpncvpgsuomoeokewfuywuwbxsqhoeirljytrectropbkscyrkbzajdmdeibhpjltzhlyndfnucjwamvbhlkryxmbwyqyiiebxbkkxjplnxknqehwjpkdolzsmpmgvrizgbmkrzhqg\r\n" [2025-04-30T08:43:42.777924665Z DEBUG quiche_apps::common] sending HTTP request "GET /fquginrwhuckpdhwrsajcbrckyohgfqzjeryoclvfefobdqmceglayzgogamggwbobcpkllpusybjenkhwilejvpjkuxmclcykqnkpfmbwcyrxrxgjpzzgeceohbsmcztadztdkfirfmpeoqddscjixzxypkhdadfvwqsmbjorxmmykykjkzhaocnoqfqanztfptdmdtzuxyahczxrkgakgpxwkxnrxaphzzehqwdemoaozjgqzsscmcaz\r\n" [2025-04-30T08:43:42.777948599Z DEBUG quiche_apps::common] sending HTTP request "GET /tsrzxdyczeghzebrrsqcminqorohltazwshtgdfbqrbpsnogrcgfmmruyrqafjxfifvstihfkuflahcghuwsihpindldyxmcxjazeaimnnsnwypicdsyoxqcgczdqeijzzywhfecconntvrwwdiudwcstvwjaxatnmleswkkebsawaqzkoxjvnbaexrnukeistxmbvrftvjmzhyqrsjqjjwjgubsqauemelmzvmpfhbxwxytzakohyilgl\r\n" [2025-04-30T08:43:42.777973856Z DEBUG quiche_apps::common] sending HTTP request "GET /afvzudmwrgbnologpzzljlomomamkjroscsugrdqmjhpwphkuhpyclooqgnutjtmsbxseviogdjhnccprueqqsyxnjzvkhzfdcbcwsrabcwhlkrczabnhbrwpbejtxankhnbiafzbwkvawxsozqkdloyrjqerzezrnyczczwfehcswyvbxsakarppvinzephdzwrzxvyznkkranidmwaykbyeebevjektipkzxadbkdlruowordxpouaof\r\n" [2025-04-30T08:43:42.777997420Z DEBUG quiche_apps::common] sending HTTP request "GET /hamvjglccnrjstqdszmehlomyfawhlozimkvwpftuestbcifxbzwubxtuolblyotjcjzrobamldudcspcamkwfjwnffkdvtdvwuqkusaazafplafzwwisgxaqdzyjmmxxugtvumjgnlhzvexdfxreeuvippuntcozrjzqpohhryftdppzmwujgzenbqjdteszylbmqqbftoyydoxalejxfndkocliwoibzuotwkpxxxivlgxihdudpggrd\r\n" [2025-04-30T08:43:42.778020183Z DEBUG quiche_apps::common] sending HTTP request "GET /svvmwzfbqqhawdxfytzlnuoqnxxsnxmhslgfnyjjcxktkvqaskwhelapfjqesiuhzmwnwbhnmqrdqegkcnojszbiangienzrsuqpowzjwxilovuodpagqxgojowzymjvwgrsiqnvkdggnqskvwqdyncwcwnzpripwyvggazcdpqlwctzyoyxxggucgzuulyivtssiygvfxwxgvbheddwlqslejrxwnwhqbsphqrkxvupbtbowhlkkpbake\r\n" [2025-04-30T08:43:42.778042584Z DEBUG quiche_apps::common] sending HTTP request "GET /udsgerwalainnbzdbmginoqkwoigfhahxttearqubfzrlgdwiukosgshorfcqdmapvdpgyqztzhogffxkzquervbsfnpfskmtubgaubetskzampcvomhzdqatjwysvfzbmpkdsmlqkubefbceygthrikpxwibuuvsgzhpvlhfpweqsihkmcaflvkrshdpiarzugrxxqrdrzhbdfffovwfyfmjjqfajphhckmhstoeygcryeodvqvrisisl\r\n" [2025-04-30T08:43:42.778065748Z DEBUG quiche_apps::common] sending HTTP request "GET /pzbdqunrmbzqwwvlndblgwjtxhyalgavlfnrzmplfdzylxqvqszufjlruaiqxmcjehyjjkdpwmybttdjyigzxdrfigiznrxywwspcgbwfuucvmwmutcmbxipzisuauehyfpauguhwslzqifdvfxymffpuhxrkknzxceoudhmrsyrvvnneubaiabltuljwfntrpdbxxhcvlctwqsuplofszantiatsixwdgqysvjaqezyfqsnjuzqpdsjcp\r\n" [2025-04-30T08:43:42.778088450Z DEBUG quiche_apps::common] sending HTTP request "GET /ljhorpipxnodbqclbqcwghulemqytspqnobbeldywyvpfqrsuwrzzhwvtcgjqkfweqljvbxdncaxqybgteuywayctfaufxncrakuvkdkovysozkkpohpquuricsgztikrpegicbuieismwnkrvlkwczeblaobtmyvwlabhqlxnzazmljpjoosfbtbkiipidthfiyoirqhxlwtmxitofigpuficnoxikjjohnrfsbujrzmiyixmbzveatvw\r\n" [2025-04-30T08:43:42.778110962Z DEBUG quiche_apps::common] sending HTTP request "GET /bvucpkvkfxgfrofxntlihonvwtsxdliwdoljkhmalaxbewoieccinncspwfvsotgqdbriaehytspcvlpnrmqmmgotyumzvwgncgxgxdasuosplpooizxujtetrfqzntzobnuriwomtnyivqhzcmidcgisxvmiupvlgixyblbpufnmzqcigcvbspmomlkaioovsucajymyizkdyivuyddukemcffqluqidhstsqzdaoguyixiecgifjfsil\r\n" [2025-04-30T08:43:42.778134155Z DEBUG quiche_apps::common] sending HTTP request "GET /tzftqadjjjocbfqphntewfexltcjmsjfrwhuxzlhyjzapcizrubgguvpzsahdwtnhjfbyjoisarjevjtfcnbjdjnpfcunofhkdrypsuoibgykhccwfwauwophbfxnpvxevrlnccxsphcdrxlnidaslrgprmwohctkwyyqsthjsvarxukqtflqbiasnqlhqmnphryrblvnyznkoivdstkfjizlpgnbazrccewspoyarlkdgyhitehfnakub\r\n" [2025-04-30T08:43:42.778179430Z DEBUG quiche_apps::common] sending HTTP request "GET /skefoqklvrvilmabigietrbasnyetgbrdzehqxlapsmsdjreifiwgxsgnqyuyivsrvyjvjgponnmcusohiqkbfctrffcuvlggphfdukggurbdkdewboyjvudquhkzaxklwhrfmeucrgoksfptfldvmqhbtkborbklvzvyckknabmmgaospgrtmxgeiwzyrgciqdgptnddjqmqyijomcnjzclqxwcrzvkkssvfbtjafksycnuoiqtaqpqgv\r\n" [2025-04-30T08:43:42.778203775Z DEBUG quiche_apps::common] sending HTTP request "GET /kamrzfzqnprkeexjfvkhzcvxtuyitzcptnycqvugetvydqvezclwdqoxoloajqbnbpyshhdpuugeizwrenecujlcihrueduwskwfvudugimepbwyddtiycxqhtxoasloqqaggwfkzpddzqwrihuxcbggncqudtcutoaxdheccoylfbhuqqdqeesgttjeynhpqzycyygtapdhpydohuepcbipobfqjutuudkthbmuiluczpajtgajzksmti\r\n" [2025-04-30T08:43:42.778230886Z DEBUG quiche_apps::common] sending HTTP request "GET /hicmvonpqgdguypyjbqcwstrmoohadbffjkkrdxsvyneuqjtahpudzpnlqgfuzoarrrlqzmdarakktbidbkkovlzdjlhxrzajcrtyyyexlriypjjdoztlbdgkbfmkatmdhdhkqmlfzfekuhfhazqhtoecuwnwyysdbjuxxcxkapcoysfhfyixhjtmjfvivzehcjfxhrxkqofmdcqbnvcrbytnuqjanjhsiyzqaddtqdppgffqfohutavoh\r\n" [2025-04-30T08:43:42.778257255Z DEBUG quiche_apps::common] sending HTTP request "GET /lrzauyqblnfybngvynjhvfzctsooffbxpwlfzkquvglkevygnpqkfojyhuzzwamcpeivxtommhzbmeofpvznpqtkcitjojueraygkdaailsxeqebvepxsmgzymulrjpcuoqqxjxqjjnqzxhqqtmwaaiatkkgnmgluecvzgfjrkzlvmcarhvpulnozhuvcjhhmifutcbmhecbakujltatvioxcvddmqxnbjsuryretxmtveipylwtrsbeyf\r\n" [2025-04-30T08:43:42.778307329Z DEBUG quiche_apps::common] sending HTTP request "GET /klqwestumzysierdwlyezwzzvurwtcgatvxqqeexkdnwlqfkybbptvdfeyygarmrvtwxcmxdrygxmtzebymszfcegvpdohwfpgahjvpslbsttuymlnaigzaidrjfvxwymjirtulwdmauqqcrulfzrzqqqzeojdbzyriitylztadgnnetumamyiylwotsvrqxeljhkdvxstfbinywhtjixrihwibczcuhhtxzwfuafyfmvzzcktxkiqcbzk\r\n" [2025-04-30T08:43:42.778334078Z DEBUG quiche_apps::common] sending HTTP request "GET /ytqhdhdjqvzqebofadiyepvjcrxfuabygkibrgkudwnugwclsdfsxxahroqofzvrlddznkvnouyuqwbiwfndhzmbxaypifcujhqxgqrimjtxwabrsnosmsboddursdduereyyhtbryxvrnrjgugydntlcozgxkxtkqlsoicjpjezxqjdzsvloddgirpexmiavuzbmohperwsjvtaxcwpekwddpjltmuilihhcpetcligpggpvivvdhlrzx\r\n" [2025-04-30T08:43:42.778360417Z DEBUG quiche_apps::common] sending HTTP request "GET /rgotpnjptmijtfirrixravygilrofrpwvydzofsqlgjmxbnzaquoydzmfxlxnsnsehezkzbbwpnksckwjrfjoavnppmqicstkwrgubeesnkvvpezabyupriaobuzdknsgcgvkbyctvvxcqchwdiadokuoxzxigtihxzicqapgnaknrrxqdskpdxwqyvhrjoeveirtxxmnqdhttepdsestaysqbkphgnabgbixlpvfybuapnextdnanrzcr\r\n" [2025-04-30T08:43:42.778386406Z DEBUG quiche_apps::common] sending HTTP request "GET /uzgglasdhejejaugwoxuwkrxwltkpmuhkyxrtffmwjnokvhiobhcymwbncnvsmpmoegqzausvbqmdbbgakqyzujgfherkljrqbxstxffrkkjjmbdzjfanbrbpmltiehiwdlaeopjablvuctdifrlbyokvgfwvswykgtyreglbrhjqpofiiyndutdnxvrihmmxuvlplbdwtwjxisnrtfghbqnmpgffkcqqqxfugblpcupapdipsnyujjprg\r\n" [2025-04-30T08:43:42.778425950Z DEBUG quiche_apps::common] sending HTTP request "GET /aljupfsquvqicmlixmzzyntxwapgbgbcrubunwosyssdtqiswqaiacjcxrrrjdaweakenevoqpspryqndzlizyatttjgqkgbqolcycojmmrjugjwafhgbwftcvwblxdbbxambrpnhkslgidyghpwdgpqkfuvbozizdqvzgabsznliqhranzildewwkowidbxasdnnbastudgabtejzibfdjwprxejmeyzssmwvwuxzjcdnlwgkfxditysz\r\n" [2025-04-30T08:43:42.778487485Z DEBUG quiche_apps::common] sending HTTP request "GET /bbbopfgudzqvqcikelbbfrfodknnwokwitcwgrrmminmbhrjavplpmgizzpdibefkstbwecgblaixqownmjryxbbylwqgtebkepbqnijxfdcpwvcnxonyibucwncndajbkhbllefqfmpglkrcxiwwyhotzhcjuxwwntucmyepdkqriamjnqkzmmjoiugqpdvecjvcsfcyhgylzdpnxenitnwevedmrdpcjvvmmxzhcdbhifudoravdxdeq\r\n" [2025-04-30T08:43:42.778517300Z DEBUG quiche_apps::common] sending HTTP request "GET /fjdxfrmtvlnonggfprtrgpltzeugzlcyhtzhxzfuafulyoiemitjkgzrhukywxuqltstmxdlrznnjypsujklegqldcvnvhmzwojosmxoiqysgxoertjsqodwfcotirkncldgbgvmgivhvmnrcavhxwkjwfjfiagfwehotcsgbhjdcbsnzqfbehvaaxecyzxslzedlxjrtsnkewzysrbgvrgevelrxrvjxhemyylplsxlrgypaicwnrflkf\r\n" [2025-04-30T08:43:42.778562835Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=1 [2025-04-30T08:43:42.778566572Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=0 off=0 len=257 fin=true [2025-04-30T08:43:42.778575068Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.6277ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=919 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146678876 }, next_time: Instant { tv_sec: 357, tv_nsec: 146678876 }, 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-30T08:43:42.778594665Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=2 [2025-04-30T08:43:42.778597470Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=4 off=0 len=257 fin=true [2025-04-30T08:43:42.778602028Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.60089ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1243 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146678876 }, next_time: Instant { tv_sec: 357, tv_nsec: 146678876 }, 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-30T08:43:42.778613490Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=3 [2025-04-30T08:43:42.778616205Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=8 off=0 len=257 fin=true [2025-04-30T08:43:42.778620362Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.582556ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1567 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146678876 }, next_time: Instant { tv_sec: 357, tv_nsec: 146678876 }, 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-30T08:43:42.778631453Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=166 pn=4 [2025-04-30T08:43:42.778636663Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=12 off=0 len=161 fin=false [2025-04-30T08:43:42.778654867Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.547991ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1795 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146678876 }, next_time: Instant { tv_sec: 357, tv_nsec: 146678876 }, 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-30T08:43:42.778691726Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.778702616Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=5 [2025-04-30T08:43:42.778707515Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=16 off=0 len=257 fin=true [2025-04-30T08:43:42.778718215Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.484132ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2119 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146821331 }, next_time: Instant { tv_sec: 357, tv_nsec: 146821331 }, 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-30T08:43:42.778741669Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=6 [2025-04-30T08:43:42.778746157Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=20 off=0 len=257 fin=true [2025-04-30T08:43:42.778754723Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.447854ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2443 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146821331 }, next_time: Instant { tv_sec: 357, tv_nsec: 146821331 }, 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-30T08:43:42.778777085Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=7 [2025-04-30T08:43:42.778779810Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=24 off=0 len=257 fin=true [2025-04-30T08:43:42.778784448Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.41846ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2767 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146821331 }, next_time: Instant { tv_sec: 357, tv_nsec: 146821331 }, 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-30T08:43:42.778795299Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=166 pn=8 [2025-04-30T08:43:42.778797773Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=28 off=0 len=161 fin=false [2025-04-30T08:43:42.778801951Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.400977ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2995 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146821331 }, next_time: Instant { tv_sec: 357, tv_nsec: 146821331 }, 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-30T08:43:42.778834492Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.778846715Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=9 [2025-04-30T08:43:42.778850973Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=32 off=0 len=257 fin=true [2025-04-30T08:43:42.778867604Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.334763ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3319 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146963667 }, next_time: Instant { tv_sec: 357, tv_nsec: 146963667 }, 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-30T08:43:42.778911295Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=10 [2025-04-30T08:43:42.778914651Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=36 off=0 len=257 fin=true [2025-04-30T08:43:42.778920332Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.282566ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3643 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146963667 }, next_time: Instant { tv_sec: 357, tv_nsec: 146963667 }, 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-30T08:43:42.778931273Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=11 [2025-04-30T08:43:42.778933767Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=40 off=0 len=257 fin=true [2025-04-30T08:43:42.778937955Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.264943ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3967 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146963667 }, next_time: Instant { tv_sec: 357, tv_nsec: 146963667 }, 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-30T08:43:42.778952773Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=166 pn=12 [2025-04-30T08:43:42.778955347Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=44 off=0 len=161 fin=false [2025-04-30T08:43:42.778959525Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.243403ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4195 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 146963667 }, next_time: Instant { tv_sec: 357, tv_nsec: 146963667 }, 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-30T08:43:42.778992376Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779004910Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=13 [2025-04-30T08:43:42.779009118Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=48 off=0 len=257 fin=true [2025-04-30T08:43:42.779019427Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.18297ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4519 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147121622 }, next_time: Instant { tv_sec: 357, tv_nsec: 147121622 }, 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-30T08:43:42.779042710Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=14 [2025-04-30T08:43:42.779047289Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=52 off=0 len=257 fin=true [2025-04-30T08:43:42.779052960Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.149899ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4843 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147121622 }, next_time: Instant { tv_sec: 357, tv_nsec: 147121622 }, 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-30T08:43:42.779068709Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=262 pn=15 [2025-04-30T08:43:42.779071304Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=56 off=0 len=257 fin=true [2025-04-30T08:43:42.779075542Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.127377ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5167 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147121622 }, next_time: Instant { tv_sec: 357, tv_nsec: 147121622 }, 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-30T08:43:42.779085931Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=166 pn=16 [2025-04-30T08:43:42.779088386Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=60 off=0 len=161 fin=false [2025-04-30T08:43:42.779092523Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.110405ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5395 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147121622 }, next_time: Instant { tv_sec: 357, tv_nsec: 147121622 }, 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-30T08:43:42.779126537Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779138469Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=17 [2025-04-30T08:43:42.779142717Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=64 off=0 len=257 fin=true [2025-04-30T08:43:42.779160801Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.041456ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5720 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147255692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147255692 }, 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-30T08:43:42.779183533Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=18 [2025-04-30T08:43:42.779186388Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=68 off=0 len=257 fin=true [2025-04-30T08:43:42.779191718Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=997.01117ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6045 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147255692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147255692 }, 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-30T08:43:42.779202328Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=19 [2025-04-30T08:43:42.779204813Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=72 off=0 len=257 fin=true [2025-04-30T08:43:42.779208951Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.993978ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6370 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147255692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147255692 }, 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-30T08:43:42.779224119Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=163 pn=20 [2025-04-30T08:43:42.779226704Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=76 off=0 len=157 fin=false [2025-04-30T08:43:42.779230952Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.971977ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6595 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147255692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147255692 }, 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-30T08:43:42.779262230Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779274413Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=21 [2025-04-30T08:43:42.779278650Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=80 off=0 len=257 fin=true [2025-04-30T08:43:42.779309077Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.892909ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6920 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147391234 }, next_time: Instant { tv_sec: 357, tv_nsec: 147391234 }, 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-30T08:43:42.779330698Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=22 [2025-04-30T08:43:42.779336709Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=84 off=0 len=257 fin=true [2025-04-30T08:43:42.779341828Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.86107ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7245 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147391234 }, next_time: Instant { tv_sec: 357, tv_nsec: 147391234 }, 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-30T08:43:42.779352478Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=23 [2025-04-30T08:43:42.779354923Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=88 off=0 len=257 fin=true [2025-04-30T08:43:42.779359080Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.843828ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7570 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147391234 }, next_time: Instant { tv_sec: 357, tv_nsec: 147391234 }, 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-30T08:43:42.779369440Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=163 pn=24 [2025-04-30T08:43:42.779371944Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=92 off=0 len=157 fin=false [2025-04-30T08:43:42.779376072Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.826846ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7795 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147391234 }, next_time: Instant { tv_sec: 357, tv_nsec: 147391234 }, 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-30T08:43:42.779410627Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779423611Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=25 [2025-04-30T08:43:42.779427759Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=96 off=0 len=257 fin=true [2025-04-30T08:43:42.779437798Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.76447ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8120 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147539872 }, next_time: Instant { tv_sec: 357, tv_nsec: 147539872 }, 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-30T08:43:42.779460740Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=26 [2025-04-30T08:43:42.779464938Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=100 off=0 len=257 fin=true [2025-04-30T08:43:42.779470078Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.732821ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8445 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147539872 }, next_time: Instant { tv_sec: 357, tv_nsec: 147539872 }, 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-30T08:43:42.779480687Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=27 [2025-04-30T08:43:42.779483172Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=104 off=0 len=257 fin=true [2025-04-30T08:43:42.779492149Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.710779ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8770 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147539872 }, next_time: Instant { tv_sec: 357, tv_nsec: 147539872 }, 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-30T08:43:42.779502769Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=163 pn=28 [2025-04-30T08:43:42.779505263Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=108 off=0 len=157 fin=false [2025-04-30T08:43:42.779509351Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.693587ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8995 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147539872 }, next_time: Instant { tv_sec: 357, tv_nsec: 147539872 }, 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-30T08:43:42.779539688Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779551339Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=29 [2025-04-30T08:43:42.779555637Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=112 off=0 len=257 fin=true [2025-04-30T08:43:42.779565125Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.637272ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9320 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147668692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147668692 }, 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-30T08:43:42.779593818Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=30 [2025-04-30T08:43:42.779596854Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=116 off=0 len=257 fin=true [2025-04-30T08:43:42.779602064Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.600834ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9645 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147668692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147668692 }, 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-30T08:43:42.779612664Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=31 [2025-04-30T08:43:42.779615148Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=120 off=0 len=257 fin=true [2025-04-30T08:43:42.779619236Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.583682ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9970 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147668692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147668692 }, 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-30T08:43:42.779629505Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=163 pn=32 [2025-04-30T08:43:42.779632020Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=124 off=0 len=157 fin=false [2025-04-30T08:43:42.779636137Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.566791ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10195 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147668692 }, next_time: Instant { tv_sec: 357, tv_nsec: 147668692 }, 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-30T08:43:42.779669911Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779682093Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=33 [2025-04-30T08:43:42.779686391Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=128 off=0 len=257 fin=true [2025-04-30T08:43:42.779698894Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.503473ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10520 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147799066 }, next_time: Instant { tv_sec: 357, tv_nsec: 147799066 }, 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-30T08:43:42.779722158Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=34 [2025-04-30T08:43:42.779726406Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=132 off=0 len=257 fin=true [2025-04-30T08:43:42.779735232Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.467235ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10845 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147799066 }, next_time: Instant { tv_sec: 357, tv_nsec: 147799066 }, 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-30T08:43:42.779753146Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=35 [2025-04-30T08:43:42.779755740Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=136 off=0 len=257 fin=true [2025-04-30T08:43:42.779760039Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.44291ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11170 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147799066 }, next_time: Instant { tv_sec: 357, tv_nsec: 147799066 }, 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-30T08:43:42.779773704Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=163 pn=36 [2025-04-30T08:43:42.779776259Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=140 off=0 len=157 fin=false [2025-04-30T08:43:42.779780457Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.422482ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11395 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147799066 }, next_time: Instant { tv_sec: 357, tv_nsec: 147799066 }, 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-30T08:43:42.779811935Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779823918Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=37 [2025-04-30T08:43:42.779828126Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=144 off=0 len=257 fin=true [2025-04-30T08:43:42.779837984Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.364484ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11720 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147941020 }, next_time: Instant { tv_sec: 357, tv_nsec: 147941020 }, 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-30T08:43:42.779866126Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=38 [2025-04-30T08:43:42.779869663Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=148 off=0 len=257 fin=true [2025-04-30T08:43:42.779890422Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.312316ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12045 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147941020 }, next_time: Instant { tv_sec: 357, tv_nsec: 147941020 }, 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-30T08:43:42.779905620Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=263 pn=39 [2025-04-30T08:43:42.779908215Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=152 off=0 len=257 fin=true [2025-04-30T08:43:42.779922121Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.280787ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12370 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147941020 }, next_time: Instant { tv_sec: 357, tv_nsec: 147941020 }, 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-30T08:43:42.779932971Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=102 pn=40 [2025-04-30T08:43:42.779938171Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=12 off=161 len=96 fin=true [2025-04-30T08:43:42.779942639Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.260299ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12534 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 147941020 }, next_time: Instant { tv_sec: 357, tv_nsec: 147941020 }, 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-30T08:43:42.779976212Z TRACE quiche_apps::client] written 1139 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.779984758Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=102 pn=41 [2025-04-30T08:43:42.779987363Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=28 off=161 len=96 fin=true [2025-04-30T08:43:42.779996710Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.205877ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12698 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 148105357 }, next_time: Instant { tv_sec: 357, tv_nsec: 148105357 }, 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-30T08:43:42.780018851Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=102 pn=42 [2025-04-30T08:43:42.780023610Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=44 off=161 len=96 fin=true [2025-04-30T08:43:42.780032136Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.170241ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12862 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 148105357 }, next_time: Instant { tv_sec: 357, tv_nsec: 148105357 }, 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-30T08:43:42.780051743Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=102 pn=43 [2025-04-30T08:43:42.780054388Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=60 off=161 len=96 fin=true [2025-04-30T08:43:42.780058816Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.144122ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13026 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 148105357 }, next_time: Instant { tv_sec: 357, tv_nsec: 148105357 }, 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-30T08:43:42.780069245Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=107 pn=44 [2025-04-30T08:43:42.780071730Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=76 off=157 len=100 fin=true [2025-04-30T08:43:42.780075898Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.12705ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13195 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 148105357 }, next_time: Instant { tv_sec: 357, tv_nsec: 148105357 }, 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-30T08:43:42.780086057Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=107 pn=45 [2025-04-30T08:43:42.780088531Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=92 off=157 len=100 fin=true [2025-04-30T08:43:42.780095314Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.107604ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13364 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, 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: 357, tv_nsec: 148105357 }, next_time: Instant { tv_sec: 357, tv_nsec: 148105357 }, 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-30T08:43:42.780105804Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt ZeroRTT version=1 dcid=756ab2939a8858a96559d827f7673c35 scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=74 pn=46 [2025-04-30T08:43:42.780108338Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=108 off=157 len=67 fin=false [2025-04-30T08:43:42.780112556Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=996.090372ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13500 app_limited=false congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 9, last_sent_packet: 46, 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: 357, tv_nsec: 148105357 }, next_time: Instant { tv_sec: 357, tv_nsec: 148105357 }, 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-30T08:43:42.780146480Z TRACE quiche_apps::client] written 966 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.780158422Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.811144667Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.811157060Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Initial version=1 dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c scid=477007ca72dbc59fde9a17e0a8ab5e3b8cde token= len=125 pn=1418705167 [2025-04-30T08:43:42.811166197Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=0 blocks=[0..0] ecn_counts=None [2025-04-30T08:43:42.811171197Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 0 [2025-04-30T08:43:42.811176146Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm CRYPTO off=0 len=96 [2025-04-30T08:43:42.811247900Z TRACE quiche::tls] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c set write secret lvl=Handshake [2025-04-30T08:43:42.811255634Z TRACE quiche::tls] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c set read secret lvl=Handshake [2025-04-30T08:43:42.811273508Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Handshake version=1 dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c scid=477007ca72dbc59fde9a17e0a8ab5e3b8cde len=191 pn=1418705167 [2025-04-30T08:43:42.811285280Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm CRYPTO off=0 len=167 [2025-04-30T08:43:42.811309956Z TRACE quiche::tls] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c write message lvl=Handshake len=36 [2025-04-30T08:43:42.811312891Z TRACE quiche::tls] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c set write secret lvl=OneRTT [2025-04-30T08:43:42.811318902Z TRACE quiche::tls] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c set read secret lvl=OneRTT [2025-04-30T08:43:42.811332347Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=true TransportParams { original_destination_connection_id: Some(756ab2939a8858a96559d827f7673c35), max_idle_timeout: 30000, stateless_reset_token: Some(173211815726859179488449707907009628148), max_udp_payload_size: 65527, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 0, initial_max_stream_data_bidi_remote: 262144, initial_max_stream_data_uni: 262144, initial_max_streams_bidi: 100, initial_max_streams_uni: 0, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 7, initial_source_connection_id: Some(477007ca72dbc59fde9a17e0a8ab5e3b8cde), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T08:43:42.811350992Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=764 pn=1418705167 [2025-04-30T08:43:42.811357364Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[54, 89, b8, cf, 42, 0b, 2f, 0b, cf, fd, c9, d2, 6c, 5a, 62, a1, a5, 1a] reset_token=[bb, 1a, a7, 76, 73, 3b, 48, 0b, 5e, cc, 77, 98, 97, 4c, cb, 2e] [2025-04-30T08:43:42.811364888Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[40, 86, a2, 06, 54, 8d, 6c, fe, 8f, 34, 7b, eb, 9f, e8, 2f, c4, c6, 82] reset_token=[ee, 47, ae, 8b, cd, 85, 83, 44, c7, e4, 74, 46, 90, 65, bc, ab] [2025-04-30T08:43:42.811370469Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[7a, ee, 57, fc, 36, f5, d3, 04, 61, 19, 45, 5a, 3a, 45, 5d, 20, 83, 65] reset_token=[5f, ea, d2, 10, 92, b0, 5c, ea, 3d, f1, e1, 40, 89, bd, 6f, ed] [2025-04-30T08:43:42.811375739Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[67, ce, ca, 8d, e3, d0, 72, e0, 43, 1c, 5c, d7, c4, 43, f3, 08, ec, 59] reset_token=[9a, 6f, c6, d1, 1b, 8c, 9d, 55, 63, e5, e1, 74, d2, 38, 76, c3] [2025-04-30T08:43:42.811381319Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[25, 6f, 46, e6, ca, b1, bb, e4, 98, d9, ca, d3, 31, 89, c0, e4, fc, e9] reset_token=[95, 16, 40, c6, fd, 53, 61, 75, f3, 22, f7, 77, 8b, 25, 82, d5] [2025-04-30T08:43:42.811386779Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[de, 50, e0, d8, 47, 25, 55, 64, 49, f4, 51, 8c, 64, 78, 00, a4, 51, 4a] reset_token=[af, 96, 21, 37, ff, b0, e3, 90, 30, 19, fc, a5, a1, c4, f7, e3] [2025-04-30T08:43:42.811392019Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[d5, a4, fb, 2d, fe, 74, cb, 0e, 2a, 2f, bc, ad, df, df, b6, b3, 6d, 4b] reset_token=[cb, 45, 25, 19, 36, 18, 51, 95, c6, 34, 8f, b9, b6, 6e, 4b, 6d] [2025-04-30T08:43:42.811397820Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=478 [2025-04-30T08:43:42.811405223Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.811409542Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.811415743Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.811426493Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Initial version=1 dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=12 pn=47 [2025-04-30T08:43:42.811429419Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=33 blocks=[1418705167..1418705167] ecn_counts=None [2025-04-30T08:43:42.811436131Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=964.766667ms latest_rtt=33.951878ms srtt=33.951878ms min_rtt=33.951878ms rttvar=16.975939ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12905 app_limited=false congestion_recovery_start_time=None Rate { delivered: 595, delivered_time: Instant { tv_sec: 357, tv_nsec: 179280585 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 9, last_sent_packet: 47, largest_acked: 0, rate_sample: RateSample { delivery_rate: 17524, is_app_limited: true, interval: 33.951878ms, delivered: 595, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 497026, last_update: Instant { tv_sec: 357, tv_nsec: 179456343 }, next_time: Instant { tv_sec: 357, tv_nsec: 179456383 }, 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=33.951878ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=1 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.811453093Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Handshake version=1 dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde scid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c len=52 pn=48 [2025-04-30T08:43:42.811455898Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=22 blocks=[1418705167..1418705167] ecn_counts=None [2025-04-30T08:43:42.811458583Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm CRYPTO off=0 len=36 [2025-04-30T08:43:42.811465526Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=95.369606ms latest_rtt=33.951878ms srtt=33.951878ms min_rtt=33.951878ms rttvar=16.975939ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13021 app_limited=true congestion_recovery_start_time=None Rate { delivered: 595, delivered_time: Instant { tv_sec: 357, tv_nsec: 179280585 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 9, last_sent_packet: 48, largest_acked: 0, rate_sample: RateSample { delivery_rate: 17524, is_app_limited: true, interval: 33.951878ms, delivered: 595, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 497026, last_update: Instant { tv_sec: 357, tv_nsec: 179545409 }, next_time: Instant { tv_sec: 357, tv_nsec: 179456383 }, max_datagram_size: 1350, last_packet_size: None, iv: 233.388µs, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms 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-30T08:43:42.811476837Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c dropped epoch 0 state [2025-04-30T08:43:42.811481345Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=479 out_len=1157 left=431 [2025-04-30T08:43:42.811488519Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=443 pn=49 [2025-04-30T08:43:42.811491114Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=16 blocks=[1418705167..1418705167] ecn_counts=None [2025-04-30T08:43:42.811496865Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[25, fe, 20, 42, 60, 1e, de, 3b, 9c, 64, b6, 63, 8b, 5b, a8, bc, 81, 59, b9, db] reset_token=[6d, c5, 9d, 6a, 8b, 68, b2, 79, 95, f3, 1a, fd, 70, cd, 15, 32] [2025-04-30T08:43:42.811502575Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[5e, d7, 0e, 0a, f3, 34, 72, df, f8, 61, 98, 70, c6, 09, 03, c5, d4, a5, 08, 5b] reset_token=[97, f7, da, 27, e2, 5e, 25, 7e, c7, 33, 3c, 4c, 27, a3, ed, 32] [2025-04-30T08:43:42.811508226Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[08, 06, 41, 1e, 9d, ee, a1, 9f, 4c, 28, 15, 35, dd, 0e, 66, 72, 2f, e3, bb, f6] reset_token=[5a, f7, 67, 95, ef, 92, 2d, 2f, 5b, 7f, a2, 97, 98, 81, 47, 94] [2025-04-30T08:43:42.811513616Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[00, a5, 87, df, 8a, 69, 58, f7, 9f, aa, ab, fa, 43, 47, c5, 21, 4d, 56, ce, 1e] reset_token=[43, b3, 4c, 08, c9, 33, dd, ad, e2, 86, 21, 81, bf, 71, 48, 1f] [2025-04-30T08:43:42.811518855Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[b2, f7, ad, 0e, db, fb, d1, da, 75, d9, 45, 6b, 41, 85, ca, 6a, 7d, bc, dc, 83] reset_token=[64, f9, a3, 3d, 7b, 91, 0f, 28, 72, 30, 87, 11, 30, cc, 68, 40] [2025-04-30T08:43:42.811524055Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[4c, 29, f8, 97, 31, e0, 5a, 31, 62, 55, 3c, 7d, c4, b4, a8, 19, 52, 42, 86, a0] reset_token=[50, bc, 5d, 97, 9c, 68, c4, 5e, 6c, 60, c7, 33, 50, fb, b2, 30] [2025-04-30T08:43:42.811529185Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=124 off=157 len=100 fin=true [2025-04-30T08:43:42.811531750Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm PADDING len=84 [2025-04-30T08:43:42.811553089Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=101.722065ms latest_rtt=33.951878ms srtt=33.951878ms min_rtt=33.951878ms rttvar=16.975939ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13500 app_limited=false congestion_recovery_start_time=None Rate { delivered: 595, delivered_time: Instant { tv_sec: 357, tv_nsec: 179280585 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 9, last_sent_packet: 49, largest_acked: 0, rate_sample: RateSample { delivery_rate: 17524, is_app_limited: true, interval: 33.951878ms, delivered: 595, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 479, rate: 497026, last_update: Instant { tv_sec: 357, tv_nsec: 179545409 }, next_time: Instant { tv_sec: 357, tv_nsec: 179778797 }, max_datagram_size: 1350, last_packet_size: Some(479), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms 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-30T08:43:42.811591571Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.811598194Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=0 out_len=1350 left=0 [2025-04-30T08:43:42.811604285Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.812119606Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.812130787Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705168 [2025-04-30T08:43:42.812142419Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=32 blocks=[1..4] ecn_counts=None [2025-04-30T08:43:42.812146186Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 1 [2025-04-30T08:43:42.812148620Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 2 [2025-04-30T08:43:42.812150774Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 3 [2025-04-30T08:43:42.812152898Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 4 [2025-04-30T08:43:42.812156645Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=0 off=0 len=32 fin=true [2025-04-30T08:43:42.812159951Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=4 off=0 len=32 fin=true [2025-04-30T08:43:42.812162987Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=8 off=0 len=32 fin=true [2025-04-30T08:43:42.812169569Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1049 [2025-04-30T08:43:42.812182704Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.812186561Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.812188885Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.812194286Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.812196690Z TRACE quiche_apps::common] stream 0 has 32 bytes (fin? true) [2025-04-30T08:43:42.812199054Z DEBUG quiche_apps::common] 1/39 responses received [2025-04-30T08:43:42.812202330Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.812204485Z TRACE quiche_apps::common] stream 4 has 32 bytes (fin? true) [2025-04-30T08:43:42.812206649Z DEBUG quiche_apps::common] 2/39 responses received [2025-04-30T08:43:42.812209734Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.812211888Z TRACE quiche_apps::common] stream 8 has 32 bytes (fin? true) [2025-04-30T08:43:42.812214042Z DEBUG quiche_apps::common] 3/39 responses received [2025-04-30T08:43:42.812220785Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=2550 out_len=1350 left=1302 [2025-04-30T08:43:42.812224843Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=119 pn=50 [2025-04-30T08:43:42.812227457Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=11 blocks=[1418705167..1418705168] ecn_counts=None [2025-04-30T08:43:42.812230162Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=140 off=157 len=100 fin=true [2025-04-30T08:43:42.812236304Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=84.391773ms latest_rtt=33.576087ms srtt=33.904903ms min_rtt=33.576087ms rttvar=12.825901ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=12455 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1795, delivered_time: Instant { tv_sec: 357, tv_nsec: 180254963 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 9, last_sent_packet: 50, largest_acked: 4, rate_sample: RateSample { delivery_rate: 52868, is_app_limited: true, interval: 33.951878ms, delivered: 1795, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 547487, last_update: Instant { tv_sec: 357, tv_nsec: 180343117 }, next_time: Instant { tv_sec: 357, tv_nsec: 179778797 }, max_datagram_size: 1350, last_packet_size: None, iv: 1.158018ms, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.812276058Z TRACE quiche_apps::client] written 155 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.812282190Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=2395 out_len=1350 left=1314 [2025-04-30T08:43:42.812286948Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=40 pn=51 [2025-04-30T08:43:42.812291246Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=108 off=224 len=33 fin=true [2025-04-30T08:43:42.812299762Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=84.327744ms latest_rtt=33.576087ms srtt=33.904903ms min_rtt=33.576087ms rttvar=12.825901ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=12531 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1795, delivered_time: Instant { tv_sec: 357, tv_nsec: 180254963 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 9, last_sent_packet: 51, largest_acked: 4, rate_sample: RateSample { delivery_rate: 52868, is_app_limited: true, interval: 33.951878ms, delivered: 1795, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 76, rate: 547487, last_update: Instant { tv_sec: 357, tv_nsec: 180343117 }, next_time: Instant { tv_sec: 357, tv_nsec: 181563401 }, max_datagram_size: 1350, last_packet_size: Some(76), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.812346099Z TRACE quiche_apps::client] written 76 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.812351609Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.813102740Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.813114142Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705169 [2025-04-30T08:43:42.813120463Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=33 blocks=[1..8] ecn_counts=None [2025-04-30T08:43:42.813123950Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 5 [2025-04-30T08:43:42.813126384Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 6 [2025-04-30T08:43:42.813128518Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 7 [2025-04-30T08:43:42.813130632Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 8 [2025-04-30T08:43:42.813134189Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=16 off=0 len=32 fin=true [2025-04-30T08:43:42.813137425Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=20 off=0 len=32 fin=true [2025-04-30T08:43:42.813140070Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=24 off=0 len=32 fin=true [2025-04-30T08:43:42.813146943Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1049 [2025-04-30T08:43:42.813159146Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.813162842Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.813165237Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.813169895Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.813177179Z TRACE quiche_apps::common] stream 16 has 32 bytes (fin? true) [2025-04-30T08:43:42.813179553Z DEBUG quiche_apps::common] 4/39 responses received [2025-04-30T08:43:42.813182840Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.813185014Z TRACE quiche_apps::common] stream 20 has 32 bytes (fin? true) [2025-04-30T08:43:42.813187188Z DEBUG quiche_apps::common] 5/39 responses received [2025-04-30T08:43:42.813190233Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.813192357Z TRACE quiche_apps::common] stream 24 has 32 bytes (fin? true) [2025-04-30T08:43:42.813194552Z DEBUG quiche_apps::common] 6/39 responses received [2025-04-30T08:43:42.813201314Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=3519 out_len=1350 left=1302 [2025-04-30T08:43:42.813204530Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=52 [2025-04-30T08:43:42.813206955Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=10 blocks=[1418705167..1418705169] ecn_counts=None [2025-04-30T08:43:42.813212715Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=70.868525ms latest_rtt=34.416966ms srtt=33.93591ms min_rtt=33.576087ms rttvar=9.68144ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=11331 app_limited=true congestion_recovery_start_time=None Rate { delivered: 2995, delivered_time: Instant { tv_sec: 357, tv_nsec: 181238297 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 9, last_sent_packet: 52, largest_acked: 8, rate_sample: RateSample { delivery_rate: 88213, is_app_limited: true, interval: 33.951878ms, delivered: 2995, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 546986, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 181563401 }, max_datagram_size: 1350, last_packet_size: None, iv: 138.943µs, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.813248011Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.813252019Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.814084993Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.814095963Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705170 [2025-04-30T08:43:42.814101924Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=30 blocks=[1..12] ecn_counts=None [2025-04-30T08:43:42.814105381Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 9 [2025-04-30T08:43:42.814107775Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 10 [2025-04-30T08:43:42.814109979Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 11 [2025-04-30T08:43:42.814112103Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 12 [2025-04-30T08:43:42.814115600Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=32 off=0 len=32 fin=true [2025-04-30T08:43:42.814118776Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=36 off=0 len=32 fin=true [2025-04-30T08:43:42.814121381Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=40 off=0 len=32 fin=true [2025-04-30T08:43:42.814133172Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1049 [2025-04-30T08:43:42.814148782Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.814152739Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.814155113Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.814159562Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.814161816Z TRACE quiche_apps::common] stream 32 has 32 bytes (fin? true) [2025-04-30T08:43:42.814164100Z DEBUG quiche_apps::common] 7/39 responses received [2025-04-30T08:43:42.814167677Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.814169831Z TRACE quiche_apps::common] stream 36 has 32 bytes (fin? true) [2025-04-30T08:43:42.814172005Z DEBUG quiche_apps::common] 8/39 responses received [2025-04-30T08:43:42.814175191Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.814177375Z TRACE quiche_apps::common] stream 40 has 32 bytes (fin? true) [2025-04-30T08:43:42.814179519Z DEBUG quiche_apps::common] 9/39 responses received [2025-04-30T08:43:42.814186362Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=4719 out_len=1350 left=1302 [2025-04-30T08:43:42.814189558Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=53 [2025-04-30T08:43:42.814191952Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=11 blocks=[1418705167..1418705170] ecn_counts=None [2025-04-30T08:43:42.814197472Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=61.417913ms latest_rtt=35.256422ms srtt=34.070973ms min_rtt=33.576087ms rttvar=7.531208ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=10131 app_limited=true congestion_recovery_start_time=None Rate { delivered: 4195, delivered_time: Instant { tv_sec: 357, tv_nsec: 182220089 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 0, last_sent_packet: 53, largest_acked: 12, rate_sample: RateSample { delivery_rate: 123557, is_app_limited: true, interval: 33.951878ms, delivered: 4195, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 544818, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 182447507 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.814231676Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.814236225Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.815068337Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.815079398Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705171 [2025-04-30T08:43:42.815085619Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=33 blocks=[1..16] ecn_counts=None [2025-04-30T08:43:42.815088986Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 13 [2025-04-30T08:43:42.815091490Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 14 [2025-04-30T08:43:42.815093614Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 15 [2025-04-30T08:43:42.815095778Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 16 [2025-04-30T08:43:42.815104374Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=48 off=0 len=32 fin=true [2025-04-30T08:43:42.815107610Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=52 off=0 len=32 fin=true [2025-04-30T08:43:42.815110195Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=56 off=0 len=32 fin=true [2025-04-30T08:43:42.815116988Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1049 [2025-04-30T08:43:42.815138819Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.815142766Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.815145120Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.815149739Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.815152023Z TRACE quiche_apps::common] stream 48 has 32 bytes (fin? true) [2025-04-30T08:43:42.815154257Z DEBUG quiche_apps::common] 10/39 responses received [2025-04-30T08:43:42.815157494Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.815159667Z TRACE quiche_apps::common] stream 52 has 32 bytes (fin? true) [2025-04-30T08:43:42.815161942Z DEBUG quiche_apps::common] 11/39 responses received [2025-04-30T08:43:42.815165048Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.815167192Z TRACE quiche_apps::common] stream 56 has 32 bytes (fin? true) [2025-04-30T08:43:42.815169345Z DEBUG quiche_apps::common] 12/39 responses received [2025-04-30T08:43:42.815175978Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=5919 out_len=1350 left=1302 [2025-04-30T08:43:42.815179074Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=54 [2025-04-30T08:43:42.815181478Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=12 blocks=[1418705167..1418705171] ecn_counts=None [2025-04-30T08:43:42.815187239Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=54.862256ms latest_rtt=36.081941ms srtt=34.289343ms min_rtt=33.576087ms rttvar=6.085148ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=8931 app_limited=true congestion_recovery_start_time=None Rate { delivered: 5395, delivered_time: Instant { tv_sec: 357, tv_nsec: 183203563 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 0, last_sent_packet: 54, largest_acked: 16, rate_sample: RateSample { delivery_rate: 158901, is_app_limited: true, interval: 33.951878ms, delivered: 5395, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 541348, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 182447507 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.815221984Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.815226031Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.816052523Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.816063564Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705172 [2025-04-30T08:43:42.816069775Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=31 blocks=[1..20] ecn_counts=None [2025-04-30T08:43:42.816073151Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 17 [2025-04-30T08:43:42.816081177Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 18 [2025-04-30T08:43:42.816083491Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 19 [2025-04-30T08:43:42.816085625Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 20 [2025-04-30T08:43:42.816089292Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=64 off=0 len=32 fin=true [2025-04-30T08:43:42.816092568Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=68 off=0 len=32 fin=true [2025-04-30T08:43:42.816095163Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=72 off=0 len=32 fin=true [2025-04-30T08:43:42.816101935Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1046 [2025-04-30T08:43:42.816114008Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.816117815Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.816120179Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.816124578Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.816126852Z TRACE quiche_apps::common] stream 64 has 32 bytes (fin? true) [2025-04-30T08:43:42.816129166Z DEBUG quiche_apps::common] 13/39 responses received [2025-04-30T08:43:42.816132252Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.816134406Z TRACE quiche_apps::common] stream 68 has 32 bytes (fin? true) [2025-04-30T08:43:42.816136580Z DEBUG quiche_apps::common] 14/39 responses received [2025-04-30T08:43:42.816140016Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.816142170Z TRACE quiche_apps::common] stream 72 has 32 bytes (fin? true) [2025-04-30T08:43:42.816144334Z DEBUG quiche_apps::common] 15/39 responses received [2025-04-30T08:43:42.816150876Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=7119 out_len=1350 left=1302 [2025-04-30T08:43:42.816154013Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=55 [2025-04-30T08:43:42.816156397Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=10 blocks=[1418705167..1418705172] ecn_counts=None [2025-04-30T08:43:42.816162097Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=50.496266ms latest_rtt=36.932007ms srtt=34.588675ms min_rtt=33.576087ms rttvar=5.162527ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=7731 app_limited=true congestion_recovery_start_time=None Rate { delivered: 6595, delivered_time: Instant { tv_sec: 357, tv_nsec: 184187699 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 0, last_sent_packet: 55, largest_acked: 20, rate_sample: RateSample { delivery_rate: 194245, is_app_limited: true, interval: 33.951878ms, delivered: 6595, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 536664, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 182447507 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.816196662Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.816200680Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.817037961Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.817049433Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705173 [2025-04-30T08:43:42.817055715Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=32 blocks=[1..24] ecn_counts=None [2025-04-30T08:43:42.817059251Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 21 [2025-04-30T08:43:42.817061655Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 22 [2025-04-30T08:43:42.817063830Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 23 [2025-04-30T08:43:42.817065943Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 24 [2025-04-30T08:43:42.817069430Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=80 off=0 len=32 fin=true [2025-04-30T08:43:42.817072656Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=84 off=0 len=32 fin=true [2025-04-30T08:43:42.817075251Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=88 off=0 len=32 fin=true [2025-04-30T08:43:42.817082033Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1046 [2025-04-30T08:43:42.817094266Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.817097963Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.817100328Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.817104656Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.817106910Z TRACE quiche_apps::common] stream 80 has 32 bytes (fin? true) [2025-04-30T08:43:42.817109244Z DEBUG quiche_apps::common] 16/39 responses received [2025-04-30T08:43:42.817112400Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.817114564Z TRACE quiche_apps::common] stream 84 has 32 bytes (fin? true) [2025-04-30T08:43:42.817116748Z DEBUG quiche_apps::common] 17/39 responses received [2025-04-30T08:43:42.817119784Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.817121908Z TRACE quiche_apps::common] stream 88 has 32 bytes (fin? true) [2025-04-30T08:43:42.817124082Z DEBUG quiche_apps::common] 18/39 responses received [2025-04-30T08:43:42.817130634Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=8319 out_len=1350 left=1302 [2025-04-30T08:43:42.817133910Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=56 [2025-04-30T08:43:42.817136345Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=10 blocks=[1418705167..1418705173] ecn_counts=None [2025-04-30T08:43:42.817141835Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=47.658876ms latest_rtt=37.782344ms srtt=34.955883ms min_rtt=33.576087ms rttvar=4.606312ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=6531 app_limited=true congestion_recovery_start_time=None Rate { delivered: 7795, delivered_time: Instant { tv_sec: 357, tv_nsec: 185173578 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 55, last_sent_packet: 56, largest_acked: 24, rate_sample: RateSample { delivery_rate: 229589, is_app_limited: true, interval: 33.951878ms, delivered: 7795, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 531026, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 182447507 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.817181639Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.817185737Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.818021677Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.818032457Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705174 [2025-04-30T08:43:42.818038498Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=30 blocks=[1..28] ecn_counts=None [2025-04-30T08:43:42.818041864Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 25 [2025-04-30T08:43:42.818044289Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 26 [2025-04-30T08:43:42.818046423Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 27 [2025-04-30T08:43:42.818048527Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 28 [2025-04-30T08:43:42.818052103Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=96 off=0 len=32 fin=true [2025-04-30T08:43:42.818055189Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=100 off=0 len=32 fin=true [2025-04-30T08:43:42.818057824Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=104 off=0 len=32 fin=true [2025-04-30T08:43:42.818064627Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1046 [2025-04-30T08:43:42.818076469Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.818080146Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.818082550Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.818086968Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.818089183Z TRACE quiche_apps::common] stream 96 has 32 bytes (fin? true) [2025-04-30T08:43:42.818091447Z DEBUG quiche_apps::common] 19/39 responses received [2025-04-30T08:43:42.818094593Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.818096726Z TRACE quiche_apps::common] stream 100 has 32 bytes (fin? true) [2025-04-30T08:43:42.818098921Z DEBUG quiche_apps::common] 20/39 responses received [2025-04-30T08:43:42.818101926Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.818104050Z TRACE quiche_apps::common] stream 104 has 32 bytes (fin? true) [2025-04-30T08:43:42.818106254Z DEBUG quiche_apps::common] 21/39 responses received [2025-04-30T08:43:42.818112636Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9519 out_len=1350 left=1302 [2025-04-30T08:43:42.818115732Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=57 [2025-04-30T08:43:42.818118117Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=10 blocks=[1418705167..1418705174] ecn_counts=None [2025-04-30T08:43:42.818123977Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=45.918909ms latest_rtt=38.61678ms srtt=35.383494ms min_rtt=33.576087ms rttvar=4.309958ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=5331 app_limited=true congestion_recovery_start_time=None Rate { delivered: 8995, delivered_time: Instant { tv_sec: 357, tv_nsec: 186156652 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 56, last_sent_packet: 57, largest_acked: 28, rate_sample: RateSample { delivery_rate: 264933, is_app_limited: true, interval: 33.951878ms, delivered: 8995, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524609, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 182447507 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.818163862Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.818168059Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.819004800Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.819015711Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705175 [2025-04-30T08:43:42.819021862Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=32 blocks=[1..32] ecn_counts=None [2025-04-30T08:43:42.819025249Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 29 [2025-04-30T08:43:42.819027633Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 30 [2025-04-30T08:43:42.819029767Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 31 [2025-04-30T08:43:42.819031881Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 32 [2025-04-30T08:43:42.819035408Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=112 off=0 len=32 fin=true [2025-04-30T08:43:42.819038543Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=116 off=0 len=32 fin=true [2025-04-30T08:43:42.819041158Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=120 off=0 len=32 fin=true [2025-04-30T08:43:42.819047901Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1046 [2025-04-30T08:43:42.819071535Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.819075483Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.819077817Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.819082215Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.819084459Z TRACE quiche_apps::common] stream 112 has 32 bytes (fin? true) [2025-04-30T08:43:42.819086744Z DEBUG quiche_apps::common] 22/39 responses received [2025-04-30T08:43:42.819089889Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.819092033Z TRACE quiche_apps::common] stream 116 has 32 bytes (fin? true) [2025-04-30T08:43:42.819094217Z DEBUG quiche_apps::common] 23/39 responses received [2025-04-30T08:43:42.819097283Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.819099407Z TRACE quiche_apps::common] stream 120 has 32 bytes (fin? true) [2025-04-30T08:43:42.819101621Z DEBUG quiche_apps::common] 24/39 responses received [2025-04-30T08:43:42.819108264Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10719 out_len=1350 left=1302 [2025-04-30T08:43:42.819111459Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=58 [2025-04-30T08:43:42.819113934Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=11 blocks=[1418705167..1418705175] ecn_counts=None [2025-04-30T08:43:42.819119645Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=44.923885ms latest_rtt=39.471145ms srtt=35.86245ms min_rtt=33.576087ms rttvar=4.19038ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=4131 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10195, delivered_time: Instant { tv_sec: 357, tv_nsec: 187139837 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 57, last_sent_packet: 58, largest_acked: 32, rate_sample: RateSample { delivery_rate: 300277, is_app_limited: true, interval: 33.951878ms, delivered: 10195, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 517602, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 182447507 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.819157275Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.819162345Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.819991171Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.820003163Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705176 [2025-04-30T08:43:42.820012430Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=31 blocks=[1..36] ecn_counts=None [2025-04-30T08:43:42.820017941Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 33 [2025-04-30T08:43:42.820021718Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 34 [2025-04-30T08:43:42.820024262Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 35 [2025-04-30T08:43:42.820026396Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 36 [2025-04-30T08:43:42.820030063Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=128 off=0 len=32 fin=true [2025-04-30T08:43:42.820033339Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=132 off=0 len=32 fin=true [2025-04-30T08:43:42.820035944Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=136 off=0 len=32 fin=true [2025-04-30T08:43:42.820042717Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1046 [2025-04-30T08:43:42.820054649Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.820061542Z TRACE quiche_apps::client] got 46 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.820067122Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=25 pn=1418705177 [2025-04-30T08:43:42.820074406Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=34 blocks=[1..40] ecn_counts=None [2025-04-30T08:43:42.820078924Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 37 [2025-04-30T08:43:42.820082711Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 38 [2025-04-30T08:43:42.820086378Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 39 [2025-04-30T08:43:42.820089935Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 40 [2025-04-30T08:43:42.820105344Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 46 bytes [2025-04-30T08:43:42.820119711Z TRACE quiche_apps::client] got 46 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.820125491Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=25 pn=1418705178 [2025-04-30T08:43:42.820130310Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=38 blocks=[1..46] ecn_counts=None [2025-04-30T08:43:42.820133346Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 41 [2025-04-30T08:43:42.820135690Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 42 [2025-04-30T08:43:42.820137874Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 43 [2025-04-30T08:43:42.820139978Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 44 [2025-04-30T08:43:42.820142643Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 45 [2025-04-30T08:43:42.820146881Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 46 [2025-04-30T08:43:42.820157391Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 46 bytes [2025-04-30T08:43:42.820161017Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.820163402Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.820167900Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.820170235Z TRACE quiche_apps::common] stream 128 has 32 bytes (fin? true) [2025-04-30T08:43:42.820172619Z DEBUG quiche_apps::common] 25/39 responses received [2025-04-30T08:43:42.820175855Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.820178019Z TRACE quiche_apps::common] stream 132 has 32 bytes (fin? true) [2025-04-30T08:43:42.820183680Z DEBUG quiche_apps::common] 26/39 responses received [2025-04-30T08:43:42.820186956Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.820189120Z TRACE quiche_apps::common] stream 136 has 32 bytes (fin? true) [2025-04-30T08:43:42.820192837Z DEBUG quiche_apps::common] 27/39 responses received [2025-04-30T08:43:42.820199900Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=14024 out_len=1350 left=1302 [2025-04-30T08:43:42.820203196Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=59 [2025-04-30T08:43:42.820205611Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=9 blocks=[1418705167..1418705178] ecn_counts=None [2025-04-30T08:43:42.820211271Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=43.559799ms latest_rtt=40.144651ms srtt=37.213594ms min_rtt=33.576087ms rttvar=3.784484ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=826 app_limited=true congestion_recovery_start_time=None Rate { delivered: 13500, delivered_time: Instant { tv_sec: 357, tv_nsec: 188250008 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 58, last_sent_packet: 59, largest_acked: 46, rate_sample: RateSample { delivery_rate: 397621, is_app_limited: true, interval: 33.951878ms, delivered: 13500, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 498809, last_update: Instant { tv_sec: 357, tv_nsec: 181323526 }, next_time: Instant { tv_sec: 357, tv_nsec: 182447507 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.820253971Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.820258139Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.845369915Z TRACE quiche_apps::client] got 1342 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.845381677Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1321 pn=1418705179 [2025-04-30T08:43:42.845388300Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PING mtu_probe=None [2025-04-30T08:43:42.845395503Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1303 [2025-04-30T08:43:42.845402416Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1342 bytes [2025-04-30T08:43:42.845406013Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.845408387Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.845415631Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=false hs_sent=false cwnd_avail=14024 out_len=1350 left=1302 [2025-04-30T08:43:42.845419137Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=60 [2025-04-30T08:43:42.845421642Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=4 blocks=[1418705167..1418705179] ecn_counts=None [2025-04-30T08:43:42.845428505Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=18.342505ms latest_rtt=40.144651ms srtt=37.213594ms min_rtt=33.576087ms rttvar=3.784484ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=826 app_limited=true congestion_recovery_start_time=None Rate { delivered: 13500, delivered_time: Instant { tv_sec: 357, tv_nsec: 188250008 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 145328707 }, end_of_app_limited: 58, last_sent_packet: 60, largest_acked: 46, rate_sample: RateSample { delivery_rate: 397621, is_app_limited: true, interval: 33.951878ms, delivered: 13500, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 145328707 }), send_elapsed: 0ns, ack_elapsed: 33.951878ms, rtt: 33.951878ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 498809, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T08:43:42.845464752Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.845468950Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.846348341Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.846359481Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705180 [2025-04-30T08:43:42.846365974Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm ACK delay=19 blocks=[9..46, 50..52] ecn_counts=None [2025-04-30T08:43:42.846369781Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 50 [2025-04-30T08:43:42.846372415Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 51 [2025-04-30T08:43:42.846374740Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet newly acked 52 [2025-04-30T08:43:42.846378677Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c packet 49 lost on epoch 2 [2025-04-30T08:43:42.846382705Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm HANDSHAKE_DONE [2025-04-30T08:43:42.846392363Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c dropped epoch 1 state [2025-04-30T08:43:42.846397242Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm NEW_TOKEN len=41 [2025-04-30T08:43:42.846400007Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm CRYPTO off=0 len=237 [2025-04-30T08:43:42.846414734Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=106 [2025-04-30T08:43:42.846417720Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=12 off=0 len=32 fin=true [2025-04-30T08:43:42.846420756Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=28 off=0 len=32 fin=true [2025-04-30T08:43:42.846423411Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=44 off=0 len=32 fin=true [2025-04-30T08:43:42.846426416Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=60 off=0 len=32 fin=true [2025-04-30T08:43:42.846429192Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=76 off=0 len=32 fin=true [2025-04-30T08:43:42.846431917Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=92 off=0 len=32 fin=true [2025-04-30T08:43:42.846434551Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=108 off=0 len=32 fin=true [2025-04-30T08:43:42.846437337Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=140 off=0 len=32 fin=true [2025-04-30T08:43:42.846440002Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=144 off=0 len=32 fin=true [2025-04-30T08:43:42.846442717Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=148 off=0 len=32 fin=true [2025-04-30T08:43:42.846445362Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=152 off=0 len=32 fin=true [2025-04-30T08:43:42.846450020Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=475 [2025-04-30T08:43:42.846465680Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.846469687Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.846472101Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.846476970Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846479345Z TRACE quiche_apps::common] stream 12 has 32 bytes (fin? true) [2025-04-30T08:43:42.846481719Z DEBUG quiche_apps::common] 28/39 responses received [2025-04-30T08:43:42.846485517Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846487721Z TRACE quiche_apps::common] stream 28 has 32 bytes (fin? true) [2025-04-30T08:43:42.846489885Z DEBUG quiche_apps::common] 29/39 responses received [2025-04-30T08:43:42.846507007Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846509301Z TRACE quiche_apps::common] stream 44 has 32 bytes (fin? true) [2025-04-30T08:43:42.846511495Z DEBUG quiche_apps::common] 30/39 responses received [2025-04-30T08:43:42.846514911Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846517096Z TRACE quiche_apps::common] stream 60 has 32 bytes (fin? true) [2025-04-30T08:43:42.846519240Z DEBUG quiche_apps::common] 31/39 responses received [2025-04-30T08:43:42.846522385Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846524529Z TRACE quiche_apps::common] stream 76 has 32 bytes (fin? true) [2025-04-30T08:43:42.846526803Z DEBUG quiche_apps::common] 32/39 responses received [2025-04-30T08:43:42.846529839Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846531973Z TRACE quiche_apps::common] stream 92 has 32 bytes (fin? true) [2025-04-30T08:43:42.846534137Z DEBUG quiche_apps::common] 33/39 responses received [2025-04-30T08:43:42.846537213Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846539347Z TRACE quiche_apps::common] stream 108 has 32 bytes (fin? true) [2025-04-30T08:43:42.846541511Z DEBUG quiche_apps::common] 34/39 responses received [2025-04-30T08:43:42.846547071Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846549265Z TRACE quiche_apps::common] stream 140 has 32 bytes (fin? true) [2025-04-30T08:43:42.846551420Z DEBUG quiche_apps::common] 35/39 responses received [2025-04-30T08:43:42.846554505Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846556639Z TRACE quiche_apps::common] stream 144 has 32 bytes (fin? true) [2025-04-30T08:43:42.846558803Z DEBUG quiche_apps::common] 36/39 responses received [2025-04-30T08:43:42.846561789Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846563933Z TRACE quiche_apps::common] stream 148 has 32 bytes (fin? true) [2025-04-30T08:43:42.846566097Z DEBUG quiche_apps::common] 37/39 responses received [2025-04-30T08:43:42.846569102Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.846571226Z TRACE quiche_apps::common] stream 152 has 32 bytes (fin? true) [2025-04-30T08:43:42.846573370Z DEBUG quiche_apps::common] 38/39 responses received [2025-04-30T08:43:42.846581225Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11976 out_len=1350 left=1302 [2025-04-30T08:43:42.846588048Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=359 pn=61 [2025-04-30T08:43:42.846590763Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=27 blocks=[1418705170..1418705180] ecn_counts=None [2025-04-30T08:43:42.846593768Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[25, fe, 20, 42, 60, 1e, de, 3b, 9c, 64, b6, 63, 8b, 5b, a8, bc, 81, 59, b9, db] reset_token=[6d, c5, 9d, 6a, 8b, 68, b2, 79, 95, f3, 1a, fd, 70, cd, 15, 32] [2025-04-30T08:43:42.846599790Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[5e, d7, 0e, 0a, f3, 34, 72, df, f8, 61, 98, 70, c6, 09, 03, c5, d4, a5, 08, 5b] reset_token=[97, f7, da, 27, e2, 5e, 25, 7e, c7, 33, 3c, 4c, 27, a3, ed, 32] [2025-04-30T08:43:42.846605430Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[08, 06, 41, 1e, 9d, ee, a1, 9f, 4c, 28, 15, 35, dd, 0e, 66, 72, 2f, e3, bb, f6] reset_token=[5a, f7, 67, 95, ef, 92, 2d, 2f, 5b, 7f, a2, 97, 98, 81, 47, 94] [2025-04-30T08:43:42.846610780Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[00, a5, 87, df, 8a, 69, 58, f7, 9f, aa, ab, fa, 43, 47, c5, 21, 4d, 56, ce, 1e] reset_token=[43, b3, 4c, 08, c9, 33, dd, ad, e2, 86, 21, 81, bf, 71, 48, 1f] [2025-04-30T08:43:42.846616000Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[b2, f7, ad, 0e, db, fb, d1, da, 75, d9, 45, 6b, 41, 85, ca, 6a, 7d, bc, dc, 83] reset_token=[64, f9, a3, 3d, 7b, 91, 0f, 28, 72, 30, 87, 11, 30, cc, 68, 40] [2025-04-30T08:43:42.846621200Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[4c, 29, f8, 97, 31, e0, 5a, 31, 62, 55, 3c, 7d, c4, b4, a8, 19, 52, 42, 86, a0] reset_token=[50, bc, 5d, 97, 9c, 68, c4, 5e, 6c, 60, c7, 33, 50, fb, b2, 30] [2025-04-30T08:43:42.846626289Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm STREAM id=124 off=157 len=100 fin=true [2025-04-30T08:43:42.846636158Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=77.264376ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 61, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.846681813Z TRACE quiche_apps::client] written 395 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.846688525Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.847331505Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.847342365Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705181 [2025-04-30T08:43:42.847348446Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=109 [2025-04-30T08:43:42.847355159Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1159 [2025-04-30T08:43:42.847361932Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.847365528Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.847367883Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.847374615Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1302 [2025-04-30T08:43:42.847377991Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=62 [2025-04-30T08:43:42.847380536Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=4 blocks=[1418705170..1418705181] ecn_counts=None [2025-04-30T08:43:42.847386978Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=76.513626ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 62, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.847422164Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.847426131Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.848314879Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.848325629Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705182 [2025-04-30T08:43:42.848336730Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=112 [2025-04-30T08:43:42.848343603Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1159 [2025-04-30T08:43:42.848350315Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.848353902Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.848356247Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.848362879Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1302 [2025-04-30T08:43:42.848366145Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=63 [2025-04-30T08:43:42.848368680Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=4 blocks=[1418705170..1418705182] ecn_counts=None [2025-04-30T08:43:42.848374981Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=75.525683ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 63, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.848409716Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.848413824Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.849304475Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.849314835Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705183 [2025-04-30T08:43:42.849320726Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=115 [2025-04-30T08:43:42.849327428Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1159 [2025-04-30T08:43:42.849334020Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.849337667Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.849340052Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.849346664Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1302 [2025-04-30T08:43:42.849350020Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=64 [2025-04-30T08:43:42.849352475Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=4 blocks=[1418705170..1418705183] ecn_counts=None [2025-04-30T08:43:42.849358937Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=74.541677ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 64, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.849399422Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.849403630Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.850287299Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.850297288Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705184 [2025-04-30T08:43:42.850303159Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=118 [2025-04-30T08:43:42.850309791Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1159 [2025-04-30T08:43:42.850316343Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.850319859Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.850322214Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.850328696Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1302 [2025-04-30T08:43:42.850331912Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=65 [2025-04-30T08:43:42.850334367Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=3 blocks=[1418705170..1418705184] ecn_counts=None [2025-04-30T08:43:42.850340508Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=73.560146ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 65, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.850379551Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.850383749Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.851269221Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.851279790Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705185 [2025-04-30T08:43:42.851285801Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=121 [2025-04-30T08:43:42.851292464Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1159 [2025-04-30T08:43:42.851298846Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.851302363Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.851304717Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.851311259Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1302 [2025-04-30T08:43:42.851314455Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=66 [2025-04-30T08:43:42.851316870Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=3 blocks=[1418705170..1418705185] ecn_counts=None [2025-04-30T08:43:42.851323101Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=72.577543ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 66, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.851356964Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.851375449Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.852263325Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.852274045Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705186 [2025-04-30T08:43:42.852280056Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=124 [2025-04-30T08:43:42.852286749Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1159 [2025-04-30T08:43:42.852293441Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.852296998Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.852299412Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.852306035Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1302 [2025-04-30T08:43:42.852314501Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=67 [2025-04-30T08:43:42.852317065Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=4 blocks=[1418705170..1418705186] ecn_counts=None [2025-04-30T08:43:42.852323397Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=71.577267ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 67, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.852358282Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.852362260Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.853238414Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.853248593Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1179 pn=1418705187 [2025-04-30T08:43:42.853254404Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=127 [2025-04-30T08:43:42.853261077Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1159 [2025-04-30T08:43:42.853267549Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1200 bytes [2025-04-30T08:43:42.853271095Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.853273440Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.853279902Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1302 [2025-04-30T08:43:42.853283067Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=12 pn=68 [2025-04-30T08:43:42.853285442Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm ACK delay=3 blocks=[1418705170..1418705187] ecn_counts=None [2025-04-30T08:43:42.853291623Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=70.609061ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=395 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 60, last_sent_packet: 68, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.853330576Z TRACE quiche_apps::client] written 48 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.853334764Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.878815980Z TRACE quiche_apps::client] got 1342 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.878827632Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx pkt Short dcid=41e1e5aab8a8e0a3e3e742f4e884810812a1512c key_phase=false len=1321 pn=1418705188 [2025-04-30T08:43:42.878834384Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm MAX_STREAMS type=bidi max=138 [2025-04-30T08:43:42.878837319Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm STREAM id=124 off=0 len=32 fin=true [2025-04-30T08:43:42.878845114Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c rx frm PADDING len=1265 [2025-04-30T08:43:42.878853249Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 1342 bytes [2025-04-30T08:43:42.878856916Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.878859311Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.878863649Z TRACE quiche_apps::common] received 32 bytes [2025-04-30T08:43:42.878866043Z TRACE quiche_apps::common] stream 124 has 32 bytes (fin? true) [2025-04-30T08:43:42.878868508Z DEBUG quiche_apps::common] 39/39 responses received [2025-04-30T08:43:42.878870822Z INFO quiche_apps::common] 39/39 response(s) received in 101.495062ms, closing... [2025-04-30T08:43:42.878896730Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11186 out_len=1350 left=1314 [2025-04-30T08:43:42.878902992Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx pkt Short dcid=477007ca72dbc59fde9a17e0a8ab5e3b8cde key_phase=false len=10 pn=69 [2025-04-30T08:43:42.878905567Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c tx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65] [2025-04-30T08:43:42.878913291Z TRACE quiche::recovery::congestion::recovery] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c timer=77.303159ms latest_rtt=32.920106ms srtt=36.676907ms min_rtt=32.920106ms rttvar=3.911735ms cwnd=10395 ssthresh=10395 bytes_in_flight=441 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 357, tv_nsec: 248780800 }) Rate { delivered: 13731, delivered_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, first_sent_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, end_of_app_limited: 68, last_sent_packet: 69, largest_acked: 52, rate_sample: RateSample { delivery_rate: 296290, is_app_limited: true, interval: 36.234694ms, delivered: 10736, prior_delivered: 2995, prior_time: Some(Instant { tv_sec: 357, tv_nsec: 181238297 }), send_elapsed: 36.234694ms, ack_elapsed: 33.24521ms, rtt: 32.920106ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 354276, last_update: Instant { tv_sec: 357, tv_nsec: 213537452 }, next_time: Instant { tv_sec: 357, tv_nsec: 213537452 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(48) last_round_min_rtt=33.951878ms current_round_min_rtt=33.576087ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=4 css_start_time=None css_round_count=0 cubic={ k=2.020620010311095 w_max=14850 } [2025-04-30T08:43:42.878950801Z TRACE quiche_apps::client] written 46 bytes from 0.0.0.0:50732 to 193.167.100.100:443 [2025-04-30T08:43:42.878954698Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:42.881784508Z TRACE quiche_apps::client] got 45 bytes from 193.167.100.100:443 to 0.0.0.0:50732 [2025-04-30T08:43:42.881794175Z TRACE quiche_apps::client] 0.0.0.0:50732: processed 45 bytes [2025-04-30T08:43:42.881797732Z TRACE quiche_apps::client] 0.0.0.0:50732: recv() would block [2025-04-30T08:43:42.881800107Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:42.881803884Z TRACE quiche_apps::client] 0.0.0.0:50732 -> 193.167.100.100:443: done writing [2025-04-30T08:43:43.037005845Z TRACE quiche_apps::client] timed out [2025-04-30T08:43:43.037021875Z TRACE quiche] 41e1e5aab8a8e0a3e3e742f4e884810812a1512c draining timeout expired [2025-04-30T08:43:43.037056740Z TRACE quiche_apps::client] done reading [2025-04-30T08:43:43.037060999Z INFO quiche_apps::client] connection closed, recv=24 sent=70 lost=1 retrans=1 sent_bytes=15612 recv_bytes=24376 lost_bytes=479 [local_addr=0.0.0.0:50732 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=24 sent=70 lost=1 retrans=1 rtt=36.676907ms min_rtt=Some(32.920106ms) rttvar=3.911735ms cwnd=10395 sent_bytes=15612 recv_bytes=24376 lost_bytes=0 stream_retrans_bytes=100 pmtu=1350 delivery_rate=296290]