[2025-09-12T05:03:41.449144992Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-09-12T05:03:41.449403084Z INFO quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:56616 with scid 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 [2025-09-12T05:03:41.449446505Z TRACE quiche::tls] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 write message lvl=Initial len=349 [2025-09-12T05:03:41.449459499Z TRACE quiche::tls] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 set write secret lvl=ZeroRTT [2025-09-12T05:03:41.449473245Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Initial version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=353 pn=0 [2025-09-12T05:03:41.449476150Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm CRYPTO off=0 len=349 [2025-09-12T05:03:41.449484766Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=998.92466ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=416 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 1, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 447477627 }, next_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, 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-09-12T05:03:41.449533046Z TRACE quiche_apps::client] written 1200 [2025-09-12T05:03:41.449538476Z TRACE quiche_apps::client] timed out [2025-09-12T05:03:41.449542214Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.449566419Z DEBUG quiche_apps::common] sending HTTP request "GET /fxhxcfbpvxmtsfhgqetceunslzefozaebjrkjodqqwofdkhcpyxrkhsbhepmzmybdaccieazmdyhevgztpbtpjcrerkroryohthhvshofoegyaewhekqbiezviatnhrerivmiecqsnxamgfmgnpyxxxefjecvibxpficaxnyfvigcwukdbgdkypksomxzhibhgpxzumjbwtrabkbjihzjsqjvmdqvpvcleoyjvuedwhggkxvnplenqkxoa\r\n" [2025-09-12T05:03:41.449606914Z DEBUG quiche_apps::common] sending HTTP request "GET /veoqwzcgwchhmeqokbjlgvtvfedfjfnlxxhuqijapophpwhrtbxerqzmxgyhfkhnyxgrzeirokjwjoblovngqothmnhejtmzscxthmeucqrcvbuzejijhmmoypzbpxafatpshcxzmlguypzozyjzqwbedzjzxzqqvmgzjfvnrxrprnqnecvvjbsbxqmchwjilaaqizxpwghiacophmifdsjgeuzjukuwmltkvcbvsuoaxslqhwazqvqprf\r\n" [2025-09-12T05:03:41.449630929Z DEBUG quiche_apps::common] sending HTTP request "GET /qvckkynbaoczncpofqiczdstensgignlwjrvwukirgdlmaaywfqnnnczsxphtzdjyiyefpzxvlnkfghpganpadsocvyvvwdwyohaysithdrsswhyacrtdbcejgastqsjqwbrricentfmuxxsipuwvlnqktfzrtysmbglnegxeoqujhhpvmwbumgnylbdrojqwewslihfrrxfjtsuqihznnhslvffmqqisvvmbeltxmafjabvsejpwppknf\r\n" [2025-09-12T05:03:41.449652229Z DEBUG quiche_apps::common] sending HTTP request "GET /wscfloskuskxsjizrdbntafmmfjahqggrzhvgavdqunxnbmctpsmtaepmfakbttpglueqmmxttqgqeowviotwgzoyueykqsfwnvaioyhmpflzjcfgdhxbhqrzhqtwidfjjccjvegbubpuzgjsvljonnstpitrwgxicuhmdxtdyiojqpqrwmshntlolnuwbhfehweifmzglzlzpcknioaxjhastyvpneadbcxpharxlngyvjquezvdhgcjq\r\n" [2025-09-12T05:03:41.449672867Z DEBUG quiche_apps::common] sending HTTP request "GET /nddwgaduxgdijehwdaggdkzxzabtegpgdqohbtnuntxxgvbsfvihmbawxbnhderxzvylmuozohxscuqflcjnbctrstqzlbrxusztquyirtjyltjcqqanlvtrkmoogoddkpicqbqyfrsqcepzxrtzyvtzyoxifrduqfkmkghsxfbzcbbjociqidbggmzvbmpctwsncxvgzfbngypeiisokdcibbacyagoevrbvmcrtxoixsfrqmvcrjyqpf\r\n" [2025-09-12T05:03:41.449693145Z DEBUG quiche_apps::common] sending HTTP request "GET /rnwhjecnmkkxzcguildhnmfmpqzbpzuevcvxicnnjrogaqrdbqoolsnlruvohashfjezfmaavwhesvlbeanqledxeccrtgefuzmzlbintaezaxglasjrgyovrhrmhmskrssyqntkhcyqiimpvbvzhoecnnovzllfxjhfvujpczjdcsqwmjidvwbdtajdyivmrysvnrydswgtyftncnwsfjcrkkqmwnddqpdlxsbydtrxmbvybfurcjieyy\r\n" [2025-09-12T05:03:41.449720346Z DEBUG quiche_apps::common] sending HTTP request "GET /swxtvsdczmdjsrbeetsfxbqxfrjltpkdqbipeuivjmkrleukqcwajwnbflnsdbrsnsxnwcoozkhoulfiurtlsnlhaapudztsndqflcroqweweszzaqmnjepgidbnavrtxarmsxrislkwhirodvnnpsesopqqqvawoilydjsgkmomrdjtxnmpxnqxnjdbvqnzecibghvrdhsfclkrmjovsuawlpnxpnsuyaniqjwygxckfiwljuhatmuwqa\r\n" [2025-09-12T05:03:41.449741446Z DEBUG quiche_apps::common] sending HTTP request "GET /cukxvdoxrlqbhazpbvrfelmvphhntrirktsnxuwblqxhmfoehtajwdgjpwiigouwplvclzyswjgvainsqkcvjmjmootbakbsggtcbjelsowlnzvygpundxevnnlwgiolwnhyxoylhlcramhxrxihvtnxxeilddpjzpfxagyhugreojdmodyzpaviikbtmenhtklatzhorbwhsdeqrnczgztkqniweygrpzrxzesdrhprycgrqepraojlxq\r\n" [2025-09-12T05:03:41.449762334Z DEBUG quiche_apps::common] sending HTTP request "GET /hosupfjsgyoadtxyuhupzyjqkpghhojmrtmibfkdzglpiqadowwpaqqtuvunrmigqrdkygtdjmjzjyvvhypkxwyhcrhkvzjcukdgimbniqrzxoocdmipqslihyziyedarwenicedggtamcdmsirybintsdtoxkegsumlhdixcbfxqdsqskmcdbqdnxgfrostwgerjtfmaiobkasfiekwlyleltyvdssquhnqknygyilpkcxiukucwhmtle\r\n" [2025-09-12T05:03:41.449784536Z DEBUG quiche_apps::common] sending HTTP request "GET /hckofmfytgsfvuqsjmgpeymanmhmsfyqafysuxuforbsztndmakeupwxexqiqkobzduosyopxoavinuwawchbkaolqpbkloaomvdyqscqyfjrixiraktymhkdounjzhglubqxuuqaumtnvismpqioczrwmltwfrniwqxxpkqnhxlgfqbvwyoukusygotcnpjbwdodrirzpsfsxzvkzwnbiiyetyyoyqrhujlmcnrcmxekqlnvhfkzuleag\r\n" [2025-09-12T05:03:41.449805234Z DEBUG quiche_apps::common] sending HTTP request "GET /yravlwatcwaeligiohoeeqxqxckozxxvzxedxuuibfdwjtipuyiobjjnvdxpivcvotspztmmwungqgxcbngdkjuxhqsphoblccujkjkfhwxeasykxvcrtbwmirjzpkaokpvxhsvhaeafzbcxogmmnmuqjarmlhjffleylqaovywivadfbynwziyzgxgvgpbmaplyijqagvfmjrbqvjrggudjhviqqqgqqcfszoatrecomqpkndrytoptpi\r\n" [2025-09-12T05:03:41.449825633Z DEBUG quiche_apps::common] sending HTTP request "GET /mgovnkppjbjfyyonpbfqhejnddofpvmdteclzycjfwbwiqxfgjqcapbshmuufxgtnvyngyqgpcuyngfkxyexbzrzgjfiwgxzusljoqukcfhczptwqdqtmnwbvgoksfhlidmfwbznfdosckvypxjzkuxulvvylrzkatjuexdylukenzdotznvhyqbwcvecymwillkwqpcaysczuimmrtfefqluvgevakymiybnleptcbumoydnpriltjrjf\r\n" [2025-09-12T05:03:41.449847373Z DEBUG quiche_apps::common] sending HTTP request "GET /nfcgyukkhqqcxeebpwmubrouzvcuxgdtfsqjjloungaobdvysmwswgpicbhoxchgorakpfdvqopodsxcprgqppakyphwgepnemzkorcnfwjgnfslbbmsoukmblvilyoxyetruduzkowlcjfgebtuxfhyffwgpuymmvqmraijcrcadobwqnyezedablkvufnccjkucoffsxkoqadqtczmdwlnfjxwycreegdkdldgzupeldnnutsvkszbfr\r\n" [2025-09-12T05:03:41.449869374Z DEBUG quiche_apps::common] sending HTTP request "GET /nnjtnlkazzhjuclynkafihnxcpytjzjeaacpioalrjcbxtvbarcgjkpksauskutsakoytywoqhbrgtsjnprhxubdwumnojkjazrfyzctvuzcpcmnulxejvgfkkaadzrznkfxduhstqybxgvlcrmpgumgcvebswilfkqstwcevidbxpbqllgtwvyfnxwahgazcpmiflkudjpqkxxlyybfwyplatqlhoyzsqnzaohsnmasnseppqdnaqnirp\r\n" [2025-09-12T05:03:41.449891976Z DEBUG quiche_apps::common] sending HTTP request "GET /njauknrcgysmacaejfeljkcnzlgughajicseypifbhfkmaxzzypfuudplxjmztawyfhfefsalmbzcuuhblvdpbtcpfwobeicvzbqeeqopjcwlzjzffcnjckszzisgeatukoedfrkgenyqoqgqzwvvykvurtvduohhpaimloimyqljlgehhhuywrpzyfgstxqyxiozupfsnhrscvoaxpasoqpyaoiwrpoixqqfmhimnujcdyhzyeuwczcwq\r\n" [2025-09-12T05:03:41.449973118Z DEBUG quiche_apps::common] sending HTTP request "GET /xatodbfopkrxsiyhxptcwhdqyxxvpnehrbpgamplrdyqnwugtqyotlrpyoqvfmfbxatmadljmuheaolswvlzurazwhwhzbdoklyejlsibxqjggtsnwzjfgvhrzlurofcxuwfhxrvenltkkxrkrlpgbjofwboghpmwqphvvmvjkubnunouttfniowlmqxsqvrzjwcfaygfseqfcanqyuplwumvzdsrtzsdyhpdokkudtkvvnplfauqqspmu\r\n" [2025-09-12T05:03:41.450003324Z DEBUG quiche_apps::common] sending HTTP request "GET /nlzlfqakiccssjxtgpjhdbqvqksqxvtossbnlpjrddxzsoagqkpzsyscyblggkghgejaxoduvtjygyrajeifpnjhbraptdhabgrhdwyupkemjbbyqfwnurebbjafalhfhmgovvgurnghqwxbmlvsbslrhtydxaiyscloarddivlbqtaepswbcrenqarbihamqxbrvekcruhaknuqxvimpkkhposedctkckoohntdcmbvoicolkzucgravv\r\n" [2025-09-12T05:03:41.450029974Z DEBUG quiche_apps::common] sending HTTP request "GET /uyvqgjigsyrbzflcygykupyakqfgnsynhwlohweklnqjeoldzxcwdtbmzvwurihuveprvlodryfscvvnfoacnqkzeewyolgmfbizxhanmusfbdeclztcrcyduwpnmrbvlxjzwlreubmatslmnxjltgtwwkktxthpiaykpcuvujsipqtitfmufixvygbvnidapdufwghwlhtojxlijkggjfpjiidwqpafpdifppovxypksvgeledtjiboil\r\n" [2025-09-12T05:03:41.450057676Z DEBUG quiche_apps::common] sending HTTP request "GET /kdkxgixkjevpylhpwiwcfesprlulqzkcfznyiasawygjwxmquqhhbfnwalrceklpqqsqepjjqfwfmclyabqpfiqxchevvkrglegpgqmlltwduqjrbkrfieulgcmtlssgzqbjoynmcbgzcwhohatadgmakbvrysiihxqyvqobhstaugyqrovmetiueudyjzfnbqybqhyuzfognjqlemorygiftiwbbdbfhqlsbasukdbprhfepibwrufsgl\r\n" [2025-09-12T05:03:41.450080448Z DEBUG quiche_apps::common] sending HTTP request "GET /xldkodvvazofvtaiexdfjpkvnxkxvwrdgtbhdyedwnjawvawysluhaiqltrffuzgubjromotrcdfwhgroneyortmxcmviechmotaqrwaucdwnbdtzcdfeitxnzycdcggdryfurkxiyiojgmnrgbcjdbbwchrvojoarersntaglvqsisjofjwoauuefsbgnwgjbqtyjwdefnhezembhbbgiodqcsohhimuvpfdwwrirkvjrlyectzvfykrl\r\n" [2025-09-12T05:03:41.450102660Z DEBUG quiche_apps::common] sending HTTP request "GET /qyfdtfkdsfptmyorbxizjbljcpiskrouznesjbfllalqyasrlvmdwrhkmamycvmvojeppmbjbmjioehsfhoyrtnxvfinyizgwqbtdsqobowhhnboglzkikxikphfxgxwghhykjdvourzeikqvnebjefzicckefsmqyktexqxhlkqedpvgvxixdkkmcydsvvnxmghynyfapevsltncrpsiixbvputvxboqdszlghuocmugmdulqzmhwkqfy\r\n" [2025-09-12T05:03:41.450125082Z DEBUG quiche_apps::common] sending HTTP request "GET /zkhelwvgnklaocrqpvnutxwmvljhnwioenuvaexfthjmofxhsxptofvkvslmtljntshxpawijzywyzmdfwtcvipqbjphwbbspayzxoheonroaiwmqlcjrvzjcoioqgfjxzyeghixlxmkrtsfmpauouitsdimycmjadikahheeivsyzypeloxknppgfrhogncefljaeissyerytlqipderghymrqtkcegpzevututynoqpunhkkuuupvmok\r\n" [2025-09-12T05:03:41.450147954Z DEBUG quiche_apps::common] sending HTTP request "GET /trgeglasamggveeskuufvrlejyomnmfzxhieqcmhpjzuibwlxkrbgyrdkvwlrgpnkhmbljfewxpzknljbvyrcqvzhijxpeokvxyxcaiupjxhyfgqsydpwdeqziwyjzclxdgyolimefxfvwvybujqbqggksrbvtzzsyfvsrsqwskkyzdwaqbgnxgasfnjhydgqepxbnqwjjdkdwqcyksmqezrvlpqysadhezoaxslotqtsccjkbjfikrlte\r\n" [2025-09-12T05:03:41.450170286Z DEBUG quiche_apps::common] sending HTTP request "GET /ofcyycaxczosqokhkzsnlhwnqadijaadrdtplrtukubwcyixnpzbohrthsbyyiuidhtsxggcpxcapencdfmwzlruwmhnvcfbxkpnccwsqratcsztqrgzuhnxxwydstrknkiwehkujiistxdevpmptmrmiltjfyckiuzddinkiveqwfllcjpwdzyfycqfsdxorwufbikdcwczwpmhrbewsvsnfqdmjwailzrqvvprsxjfscuqyqloluiiww\r\n" [2025-09-12T05:03:41.450192357Z DEBUG quiche_apps::common] sending HTTP request "GET /unhjdnmojcwtlbnwbkdpeveotnzkcnbsagmolrghxkdnfaxmreixutocqvdpkkrljfcmjsflgrgtedfdiwcfidsnlozcbpzqmaprqzyzysvnhzsordrprkhadhfcudjtsilhhuwoydghsvngtszbadernylqchsxiidkfpfecqfpfgbxyvorhdspykdihsdattzvowfoqqtxysdvuzujgbolpnfnbocchyppfohmxxmhdizqbensagkhjv\r\n" [2025-09-12T05:03:41.450215591Z DEBUG quiche_apps::common] sending HTTP request "GET /oqvyusbqmpkbzrufjempsmqdygpiqgyjqzwavznlyhqzjaeewaosogzllbcswutmrdnlihiyzaauoiupsegxrfaugxaaqynoejcevlvgyyjhnvxerrnndjvrkrvdppyqiwjgvjzjgubixdmctpmqpkmrezndananlhuotnbkcxvtslvqjhihqtlxtdguqijcwwgaqnpcvlqajavefwlbpfjslzddynhmvaiznwcquoaznizzzyhfnsujlt\r\n" [2025-09-12T05:03:41.450237922Z DEBUG quiche_apps::common] sending HTTP request "GET /hymefwdnsktfziqdqxubmpvjyjszlrgdfxtdqzapxfhptyruvoetawsmestxoxrwxpixaidiuxjkxisyjrgiwnnmlqblfqqitzjolabyflynzkcyzqiqfxevdfkhuellrulksrgjapwwizhefmxbnbilnsremeydyrlllvcnsufpjhfdadwrskeesgbnbirdiityswijbsnhewnkaxwtilqlkvzusqnpcoyxdqxiqxkujrvgrlrdjuayfl\r\n" [2025-09-12T05:03:41.450282345Z DEBUG quiche_apps::common] sending HTTP request "GET /dcuoaaefimocmneilzzwpdydnnebcbimkaaohilqcqhwotvphsefhwjewiujlyicvnvsswvqwzfmvuqcmpqhqdjfqjbgbftubyunarhqwkczuzxwbkgyacvwootcsxotuopbndenouhedpkkubjuzedtpqsionrbmmnuakabxnabeksljlghikiuyttwxpgbsmmkucjrwksasokjorydooxtunahjvndslvybysshwgoteguedftlluogx\r\n" [2025-09-12T05:03:41.450310438Z DEBUG quiche_apps::common] sending HTTP request "GET /swihluowdrktnmggawualqglbkzggflvionqkfxoczqwffwhipahbqhbdjaplocbkwnqqtnzkhfqmcdhcspdabaiehzukhhpyikulnzisouzkwnadmabrmwjoeckdhfcjkgviaggewzqfqcjvqymkzfvkugmucozdqbjwosnpzlpdhbrkolvcogfwqhxdtgevmfcihyfbdopuooqsjwooaqtezxpftasyeoqvfrvzwpjusvedoldbhwebb\r\n" [2025-09-12T05:03:41.450334803Z DEBUG quiche_apps::common] sending HTTP request "GET /uiwinqiyijgpssndxexokzqloupieforupmnelqfnmnaloysqgstfaiwawweiutfucpwgzwxpueavvtosxygmryrqpehnmqygiwjflbqkvgympxpvzcrhbzlhvtdwswaqvkebiyvccfpcjyqwiwvsmwaottiojauzhlxglfnzwfzvkgxsppatyshkoqwjykntduqliwutjhtjdpswxounrdggglbubcyarvryzxbwwuyjfqjkgirdxlqcu\r\n" [2025-09-12T05:03:41.450365330Z DEBUG quiche_apps::common] sending HTTP request "GET /nwctxvgnrnnoakhxmhmistszxbfvjxjfrwgeaebzhwkmqmkfdesidvqswybchqqwxlaahrptiwcfusqmhbqzzyztpyczgzldbyjluunphmgsnhtspljyqazvgctrchxejcbwxcmukuiyhjkfrafyebofctqmkplqpipontzbdvnvpxtjijiqktlbeckdgqalxxxiklrsrmgbcjmegrhdunvcnawhtprkfpkquhbeemnezfawqjvlredvmw\r\n" [2025-09-12T05:03:41.450390878Z DEBUG quiche_apps::common] sending HTTP request "GET /bkcohpqosrnavqxhyryomcwcwejsjuozmpglwxjlwfkcxdbaxzktdqxonbzfkqifkdyveuffemthkeotrgrsmtvssckymyjujgoebassszfnmrxydzsqclowtramdfnzqmsivlfifxlvwrmtaznjrwzyruaembuiqogaakahgkubbsopunnvfofvouvdhhtigtklmuabeenumcwcohmxekxqvpuvrdiwuzrituowxroymyonygcowizypv\r\n" [2025-09-12T05:03:41.450416195Z DEBUG quiche_apps::common] sending HTTP request "GET /qdbskfkzeihspeciqyzluuyjlzqoimvittudvmtawezhcecdwlxicsvkgwhsrpzkwbknptgpnjnepsyxghhfqwrnnqvkpoxyhilveykbemlhrrrukeisbmdxzxnygoovwkdwkqkmjrzutjexxpfxnleznngvefuehmxcdpofpsouekblqfvzkxbpogudpxmfnjletapcbochxobdqgkuhxjahzzcfggalmfueistcfegujaowbqeiegyyd\r\n" [2025-09-12T05:03:41.450444197Z DEBUG quiche_apps::common] sending HTTP request "GET /nupigjbwddvrcvyavdlbmjydyqkjonynafiwebolahwsuplvgsaqvugemnpogxjbyicawfzcvplknhduafxqiwccbnmvgehizpjfvkfcgfuqmcwxsrehvkojdgpfqslonqperxyekqkdtwbwcllbwycykalepaljlpswzxzhzztbaamnxpliznktsqcohzywopudcljsibfrkrficealrnlggsfkdylwdsstosojievilpmtjofqzqaoxu\r\n" [2025-09-12T05:03:41.450490774Z DEBUG quiche_apps::common] sending HTTP request "GET /glegotkjmnkzlfehljdvtbzbfswadjqmziosxlbfbrnlmpeflyfkdgkewdvqgqfvtxjzxjfvxsajsawlviwkykvvkatvkzcrolsbkizvmgfoeftofwlbrsbezolciwrycihobhvrhwoivmzbyfiqfqhyedcdddmrumskrpmtrzatilmxbftqwgcrfpczgxkuhycrynefowebdjiyvqrynbktorwhgmvynztwspfhjmngmqyskbeetpqgzi\r\n" [2025-09-12T05:03:41.450516933Z DEBUG quiche_apps::common] sending HTTP request "GET /azjsjglcnskmvqltyajwaanpldzgvrqcnhkgyoerqurbqvxbcxmscanwpsxbfafrvtjgaisqojdshndornuyoypjpunfpikcjrzryvnerdwnrvkzjjyfhfeuybhnhnefheiopyyqcallqvvxdrdrjeexjbatxaqqehzljwyubfsnzrxutzhixwnirxhkwrqsjfmzbecilbkekuegdtvxwjmdlunxvmlbhqesskasmspoywergnlchyacwi\r\n" [2025-09-12T05:03:41.450541599Z DEBUG quiche_apps::common] sending HTTP request "GET /ymotdowselkgsbbviyjkzphhxrlmmjhbnmqswzjbsyamgicqewvjphtkcbzaabqxsxcegmjmrlekjedkgwzaqtsylwtckyykldxzsaksouekimlhimycswgdcvoweuscrddtmeorwxgkpxulbwfnxggfleamsayxqbpzhrzgkfryhidbvddwlssnuvqigxnnfrerhzigxyuwpzklpmwgkexeunnqhonhbouevlutzhuiezkmbfvalssntq\r\n" [2025-09-12T05:03:41.450566155Z DEBUG quiche_apps::common] sending HTTP request "GET /kiytccjbfjrkqaudwjgmzesrifwzoozdnlwogwiielulgpjcclcfruixffxmqwizmvtcmdnlntoopmcxzhjmlsdtmueruywcvaltpblwcqlblratgsuhxgkjpoobesrflbgkyjpwrzsjqdamlwmdvadrtltuqatlcqjpuoalolhtdbsaqldhdfslreckdkmgkffkwjtecrfpwguuflqflmleimbperajiglarojopbxaxxgurorrohsmlt\r\n" [2025-09-12T05:03:41.450590611Z DEBUG quiche_apps::common] sending HTTP request "GET /xmpqagfkkcipfasqzwbjwhgduycxipuacwbdhthdvazhelpshddhikfcjgsqctuynzawyftrvtwojwnxclxgsdhyycbpuasphvugjskizgjkxhidcuheqzeoeoaipsjuxuquhwqhiwtcbxdxntexmetirvoyesvnayjgdbsoqdfivwbqapqlgclcjrtvfogrvmpcwdycyvyfxnkawtrmplttwydfdsqkpdzmwzieltroqkgsoehmyzucpr\r\n" [2025-09-12T05:03:41.450631788Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=1 [2025-09-12T05:03:41.450635444Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=0 off=0 len=257 fin=true [2025-09-12T05:03:41.450643559Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.765846ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=740 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448690501 }, next_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, 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-09-12T05:03:41.450663407Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=2 [2025-09-12T05:03:41.450666081Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=4 off=0 len=257 fin=true [2025-09-12T05:03:41.450670730Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.738806ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1064 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448690501 }, next_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, 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-09-12T05:03:41.450682422Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=3 [2025-09-12T05:03:41.450684967Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=8 off=0 len=257 fin=true [2025-09-12T05:03:41.450689155Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.720442ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1388 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448690501 }, next_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, 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-09-12T05:03:41.450714291Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=166 pn=4 [2025-09-12T05:03:41.450719511Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=12 off=0 len=161 fin=false [2025-09-12T05:03:41.450724701Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.684845ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1616 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448690501 }, next_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, 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-09-12T05:03:41.450758314Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.450773853Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=5 [2025-09-12T05:03:41.450778261Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=16 off=0 len=257 fin=true [2025-09-12T05:03:41.450787668Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.621838ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1940 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448832055 }, next_time: Instant { tv_sec: 541, tv_nsec: 448832055 }, 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-09-12T05:03:41.450800412Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=6 [2025-09-12T05:03:41.450802907Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=20 off=0 len=257 fin=true [2025-09-12T05:03:41.450807155Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.602452ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2264 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448832055 }, next_time: Instant { tv_sec: 541, tv_nsec: 448832055 }, 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-09-12T05:03:41.450822644Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=7 [2025-09-12T05:03:41.450825138Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=24 off=0 len=257 fin=true [2025-09-12T05:03:41.450829336Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.58025ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2588 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448832055 }, next_time: Instant { tv_sec: 541, tv_nsec: 448832055 }, 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-09-12T05:03:41.450840126Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=166 pn=8 [2025-09-12T05:03:41.450842631Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=28 off=0 len=161 fin=false [2025-09-12T05:03:41.450846739Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.562827ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2816 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448832055 }, next_time: Instant { tv_sec: 541, tv_nsec: 448832055 }, 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-09-12T05:03:41.450874741Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.450889539Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=9 [2025-09-12T05:03:41.450893797Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=32 off=0 len=257 fin=true [2025-09-12T05:03:41.450907402Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.502044ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3140 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 8, last_sent_packet: 9, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448948422 }, next_time: Instant { tv_sec: 541, tv_nsec: 448948422 }, 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-09-12T05:03:41.450920246Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=10 [2025-09-12T05:03:41.450922811Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=36 off=0 len=257 fin=true [2025-09-12T05:03:41.450927099Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.482518ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3464 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 9, last_sent_packet: 10, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448948422 }, next_time: Instant { tv_sec: 541, tv_nsec: 448948422 }, 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-09-12T05:03:41.450958317Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=11 [2025-09-12T05:03:41.450961062Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=40 off=0 len=257 fin=true [2025-09-12T05:03:41.450965841Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.443675ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3788 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 11, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448948422 }, next_time: Instant { tv_sec: 541, tv_nsec: 448948422 }, 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-09-12T05:03:41.450981120Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=166 pn=12 [2025-09-12T05:03:41.450983725Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=44 off=0 len=161 fin=false [2025-09-12T05:03:41.450987993Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.421574ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4016 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 12, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 448948422 }, next_time: Instant { tv_sec: 541, tv_nsec: 448948422 }, 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-09-12T05:03:41.451017227Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451031844Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=13 [2025-09-12T05:03:41.451036533Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=48 off=0 len=257 fin=true [2025-09-12T05:03:41.451044588Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.364928ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4340 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 13, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449090457 }, next_time: Instant { tv_sec: 541, tv_nsec: 449090457 }, 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-09-12T05:03:41.451056601Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=14 [2025-09-12T05:03:41.451059055Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=52 off=0 len=257 fin=true [2025-09-12T05:03:41.451063153Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.346434ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4664 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 14, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449090457 }, next_time: Instant { tv_sec: 541, tv_nsec: 449090457 }, 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-09-12T05:03:41.451077960Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=262 pn=15 [2025-09-12T05:03:41.451080425Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=56 off=0 len=257 fin=true [2025-09-12T05:03:41.451084573Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.324994ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4988 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 15, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449090457 }, next_time: Instant { tv_sec: 541, tv_nsec: 449090457 }, 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-09-12T05:03:41.451095052Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=166 pn=16 [2025-09-12T05:03:41.451097477Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=60 off=0 len=161 fin=false [2025-09-12T05:03:41.451101544Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.308042ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5216 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 16, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449090457 }, next_time: Instant { tv_sec: 541, tv_nsec: 449090457 }, 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-09-12T05:03:41.451131711Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451146889Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=17 [2025-09-12T05:03:41.451151237Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=64 off=0 len=257 fin=true [2025-09-12T05:03:41.451164893Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.244533ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5541 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 17, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449205292 }, next_time: Instant { tv_sec: 541, tv_nsec: 449205292 }, 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-09-12T05:03:41.451177687Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=18 [2025-09-12T05:03:41.451180221Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=68 off=0 len=257 fin=true [2025-09-12T05:03:41.451184640Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.224927ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5866 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 18, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449205292 }, next_time: Instant { tv_sec: 541, tv_nsec: 449205292 }, 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-09-12T05:03:41.451195059Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=19 [2025-09-12T05:03:41.451197524Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=72 off=0 len=257 fin=true [2025-09-12T05:03:41.451201631Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.207965ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 19, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449205292 }, next_time: Instant { tv_sec: 541, tv_nsec: 449205292 }, 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-09-12T05:03:41.451216279Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=163 pn=20 [2025-09-12T05:03:41.451218773Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=76 off=0 len=157 fin=false [2025-09-12T05:03:41.451222921Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.186665ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6416 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 20, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449205292 }, next_time: Instant { tv_sec: 541, tv_nsec: 449205292 }, 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-09-12T05:03:41.451250572Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451265250Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=21 [2025-09-12T05:03:41.451269788Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=80 off=0 len=257 fin=true [2025-09-12T05:03:41.451292330Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.117066ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6741 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 21, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449323993 }, next_time: Instant { tv_sec: 541, tv_nsec: 449323993 }, 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-09-12T05:03:41.451307910Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=22 [2025-09-12T05:03:41.451310414Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=84 off=0 len=257 fin=true [2025-09-12T05:03:41.451314852Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.094724ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7066 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 22, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449323993 }, next_time: Instant { tv_sec: 541, tv_nsec: 449323993 }, 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-09-12T05:03:41.451325863Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=23 [2025-09-12T05:03:41.451328308Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=88 off=0 len=257 fin=true [2025-09-12T05:03:41.451332425Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.077161ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7391 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 23, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449323993 }, next_time: Instant { tv_sec: 541, tv_nsec: 449323993 }, 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-09-12T05:03:41.451342775Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=163 pn=24 [2025-09-12T05:03:41.451345219Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=92 off=0 len=157 fin=false [2025-09-12T05:03:41.451349277Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.06032ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7616 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 24, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449323993 }, next_time: Instant { tv_sec: 541, tv_nsec: 449323993 }, 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-09-12T05:03:41.451379303Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451393640Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=25 [2025-09-12T05:03:41.451398128Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=96 off=0 len=257 fin=true [2025-09-12T05:03:41.451405752Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=997.003724ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7941 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 25, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449452493 }, next_time: Instant { tv_sec: 541, tv_nsec: 449452493 }, 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-09-12T05:03:41.451417765Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=26 [2025-09-12T05:03:41.451420219Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=100 off=0 len=257 fin=true [2025-09-12T05:03:41.451424487Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.985099ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8266 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 26, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449452493 }, next_time: Instant { tv_sec: 541, tv_nsec: 449452493 }, 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-09-12T05:03:41.451434776Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=27 [2025-09-12T05:03:41.451441279Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=104 off=0 len=257 fin=true [2025-09-12T05:03:41.451445556Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.96403ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8591 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 27, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449452493 }, next_time: Instant { tv_sec: 541, tv_nsec: 449452493 }, 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-09-12T05:03:41.451456136Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=163 pn=28 [2025-09-12T05:03:41.451458611Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=108 off=0 len=157 fin=false [2025-09-12T05:03:41.451462648Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.946928ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8816 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 28, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449452493 }, next_time: Instant { tv_sec: 541, tv_nsec: 449452493 }, 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-09-12T05:03:41.451489048Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451502643Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=29 [2025-09-12T05:03:41.451506831Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=112 off=0 len=257 fin=true [2025-09-12T05:03:41.451516128Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.893117ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9141 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 29, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449562418 }, next_time: Instant { tv_sec: 541, tv_nsec: 449562418 }, 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-09-12T05:03:41.451532910Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=30 [2025-09-12T05:03:41.451535414Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=116 off=0 len=257 fin=true [2025-09-12T05:03:41.451539803Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.869784ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9466 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 30, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449562418 }, next_time: Instant { tv_sec: 541, tv_nsec: 449562418 }, 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-09-12T05:03:41.451550492Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=31 [2025-09-12T05:03:41.451552937Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=120 off=0 len=257 fin=true [2025-09-12T05:03:41.451557105Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.852481ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9791 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 31, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449562418 }, next_time: Instant { tv_sec: 541, tv_nsec: 449562418 }, 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-09-12T05:03:41.451567524Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=163 pn=32 [2025-09-12T05:03:41.451569959Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=124 off=0 len=157 fin=false [2025-09-12T05:03:41.451574026Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.83556ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10016 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 32, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449562418 }, next_time: Instant { tv_sec: 541, tv_nsec: 449562418 }, 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-09-12T05:03:41.451603762Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451617838Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=33 [2025-09-12T05:03:41.451622236Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=128 off=0 len=257 fin=true [2025-09-12T05:03:41.451633587Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.775818ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10341 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 33, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449676922 }, next_time: Instant { tv_sec: 541, tv_nsec: 449676922 }, 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-09-12T05:03:41.451646802Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=34 [2025-09-12T05:03:41.451649337Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=132 off=0 len=257 fin=true [2025-09-12T05:03:41.451653595Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.755971ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10666 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 34, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449676922 }, next_time: Instant { tv_sec: 541, tv_nsec: 449676922 }, 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-09-12T05:03:41.451668092Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=35 [2025-09-12T05:03:41.451670587Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=136 off=0 len=257 fin=true [2025-09-12T05:03:41.451674764Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.734792ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10991 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 35, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449676922 }, next_time: Instant { tv_sec: 541, tv_nsec: 449676922 }, 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-09-12T05:03:41.451685304Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=163 pn=36 [2025-09-12T05:03:41.451687779Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=140 off=0 len=157 fin=false [2025-09-12T05:03:41.451691856Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.71774ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11216 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 36, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449676922 }, next_time: Instant { tv_sec: 541, tv_nsec: 449676922 }, 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-09-12T05:03:41.451718857Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451733153Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=37 [2025-09-12T05:03:41.451737391Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=144 off=0 len=257 fin=true [2025-09-12T05:03:41.451744875Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.664611ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11541 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 37, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449792267 }, next_time: Instant { tv_sec: 541, tv_nsec: 449792267 }, 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-09-12T05:03:41.451761236Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=38 [2025-09-12T05:03:41.451763750Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=148 off=0 len=257 fin=true [2025-09-12T05:03:41.451775402Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.634094ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11866 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 38, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449792267 }, next_time: Instant { tv_sec: 541, tv_nsec: 449792267 }, 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-09-12T05:03:41.451786132Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=263 pn=39 [2025-09-12T05:03:41.451788597Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=152 off=0 len=257 fin=true [2025-09-12T05:03:41.451792795Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.616812ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 39, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449792267 }, next_time: Instant { tv_sec: 541, tv_nsec: 449792267 }, 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-09-12T05:03:41.451805689Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=102 pn=40 [2025-09-12T05:03:41.451808153Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=12 off=161 len=96 fin=true [2025-09-12T05:03:41.451812421Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.597145ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12355 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 40, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449792267 }, next_time: Instant { tv_sec: 541, tv_nsec: 449792267 }, 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-09-12T05:03:41.451842448Z TRACE quiche_apps::client] written 1139 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.451856363Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=102 pn=41 [2025-09-12T05:03:41.451860531Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=28 off=161 len=96 fin=true [2025-09-12T05:03:41.451871672Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.537784ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12519 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 41, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449916018 }, next_time: Instant { tv_sec: 541, tv_nsec: 449916018 }, 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-09-12T05:03:41.451883835Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=102 pn=42 [2025-09-12T05:03:41.451886309Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=44 off=161 len=96 fin=true [2025-09-12T05:03:41.451890487Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.519109ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12683 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 42, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449916018 }, next_time: Instant { tv_sec: 541, tv_nsec: 449916018 }, 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-09-12T05:03:41.451904633Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=102 pn=43 [2025-09-12T05:03:41.451907118Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=60 off=161 len=96 fin=true [2025-09-12T05:03:41.451911256Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.49832ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12847 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 43, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449916018 }, next_time: Instant { tv_sec: 541, tv_nsec: 449916018 }, 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-09-12T05:03:41.451921545Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=107 pn=44 [2025-09-12T05:03:41.451924020Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=76 off=157 len=100 fin=true [2025-09-12T05:03:41.451928057Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.481489ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13016 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 44, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449916018 }, next_time: Instant { tv_sec: 541, tv_nsec: 449916018 }, 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-09-12T05:03:41.451959035Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=107 pn=45 [2025-09-12T05:03:41.451964996Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=92 off=157 len=100 fin=true [2025-09-12T05:03:41.451969975Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.439561ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13185 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 45, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449916018 }, next_time: Instant { tv_sec: 541, tv_nsec: 449916018 }, 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-09-12T05:03:41.451980776Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=107 pn=46 [2025-09-12T05:03:41.451983200Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=108 off=157 len=100 fin=true [2025-09-12T05:03:41.451987288Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.422318ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13354 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 46, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449916018 }, next_time: Instant { tv_sec: 541, tv_nsec: 449916018 }, 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-09-12T05:03:41.451997517Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt ZeroRTT version=1 dcid=d16eadc5f419b315c2804f7dd454795d scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=84 pn=47 [2025-09-12T05:03:41.451999962Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=124 off=157 len=77 fin=false [2025-09-12T05:03:41.452004069Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=996.405537ms 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: 541, tv_nsec: 447477627 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 447477627 }, end_of_app_limited: 10, last_sent_packet: 47, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 541, tv_nsec: 449916018 }, next_time: Instant { tv_sec: 541, tv_nsec: 449916018 }, 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-09-12T05:03:41.452037852Z TRACE quiche_apps::client] written 1145 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.452051758Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.482106332Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.482123053Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Initial version=1 dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 scid=9e3c81c4bb3acff6 token= len=122 pn=0 [2025-09-12T05:03:41.482133172Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=34 blocks=[0..0] ecn_counts=None [2025-09-12T05:03:41.482138242Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 0 [2025-09-12T05:03:41.482143431Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm CRYPTO off=0 len=96 [2025-09-12T05:03:41.482235653Z TRACE quiche::tls] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 set write secret lvl=Handshake [2025-09-12T05:03:41.482248107Z TRACE quiche::tls] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 set read secret lvl=Handshake [2025-09-12T05:03:41.482279876Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Handshake version=1 dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 scid=9e3c81c4bb3acff6 len=1003 pn=0 [2025-09-12T05:03:41.482292510Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm CRYPTO off=0 len=185 [2025-09-12T05:03:41.482343585Z TRACE quiche::tls] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 write message lvl=Handshake len=36 [2025-09-12T05:03:41.482351169Z TRACE quiche::tls] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 set write secret lvl=OneRTT [2025-09-12T05:03:41.482362230Z TRACE quiche::tls] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 set read secret lvl=OneRTT [2025-09-12T05:03:41.482381596Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 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(d16eadc5f419b315c2804f7dd454795d), max_idle_timeout: 30000, stateless_reset_token: Some(58121375191932666099109174637003639718), max_udp_payload_size: 1472, initial_max_data: 4611686018427387903, initial_max_stream_data_bidi_local: 1250000, initial_max_stream_data_bidi_remote: 1250000, initial_max_stream_data_uni: 1250000, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 5, initial_source_connection_id: Some(9e3c81c4bb3acff6), retry_source_connection_id: None, max_datagram_frame_size: Some(65535), unknown_params: None } [2025-09-12T05:03:41.482396935Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm PADDING len=797 [2025-09-12T05:03:41.482413195Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 1200 bytes [2025-09-12T05:03:41.482420248Z TRACE quiche_apps::client] got 234 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.482424947Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=213 pn=0 [2025-09-12T05:03:41.482432271Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[db, ce, d6, ba, 7d, d9, d5, 93] reset_token=[17, 6e, 7e, 2e, 0e, aa, ba, 90, 7c, fc, e4, 62, b7, f1, 6f, 2e] [2025-09-12T05:03:41.482439734Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[40, 95, d0, a0, 94, a1, f7, 62] reset_token=[50, 2e, f0, 06, 1e, 4a, 4a, 04, 20, 91, 75, a2, e0, 2e, 5a, 47] [2025-09-12T05:03:41.482452859Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[4d, 53, 6f, e9, 6b, 24, 2b, 9b] reset_token=[1c, aa, ff, 36, bb, 7d, 41, f7, 5a, ee, 7a, 68, 92, 6b, 3d, 77] [2025-09-12T05:03:41.482458680Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[48, 99, 12, 62, 70, 8a, a7, 69] reset_token=[c1, cc, c9, 03, 80, a3, 5d, 7f, 0b, be, eb, 47, 4c, a8, ef, db] [2025-09-12T05:03:41.482465022Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[8e, 60, 59, f2, d2, 3e, dc, 00] reset_token=[b6, c4, 99, 67, 1e, 34, f6, 1b, 1c, db, 88, 56, f4, 36, 52, d3] [2025-09-12T05:03:41.482470913Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[cd, 5b, dc, 91, 08, ab, a2, 01] reset_token=[66, 1a, bf, 7c, 9d, 33, 2d, 04, bf, 5d, 62, 50, e6, 60, 66, c9] [2025-09-12T05:03:41.482476804Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[ba, c8, 2a, c7, 39, 85, 5a, a5] reset_token=[27, fd, 36, 50, b9, d8, 91, 2a, ce, 08, 60, 49, ea, 56, 91, dc] [2025-09-12T05:03:41.482487403Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 234 bytes [2025-09-12T05:03:41.482492764Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.482496731Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=1 [2025-09-12T05:03:41.482502111Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=2 blocks=[1..4] ecn_counts=None [2025-09-12T05:03:41.482506549Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 1 [2025-09-12T05:03:41.482509745Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 2 [2025-09-12T05:03:41.482512691Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 3 [2025-09-12T05:03:41.482515546Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 4 [2025-09-12T05:03:41.482543027Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.482548808Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.482552024Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.482564878Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Initial version=1 dcid=9e3c81c4bb3acff6 scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=5 pn=48 [2025-09-12T05:03:41.482568615Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=55 blocks=[0..0] ecn_counts=None [2025-09-12T05:03:41.482578484Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=76.778802ms latest_rtt=31.873549ms srtt=32.606153ms min_rtt=31.873549ms rttvar=12.475869ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=11884 app_limited=false congestion_recovery_start_time=None Rate { delivered: 1616, delivered_time: Instant { tv_sec: 541, tv_nsec: 480564050 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, end_of_app_limited: 10, last_sent_packet: 48, largest_acked: 4, rate_sample: RateSample { bandwidth: 390.73 Kbps, is_app_limited: true, interval: 33.086423ms, delivered: 1616, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 447477627 }), send_elapsed: 1.212874ms, ack_elapsed: 33.086423ms, rtt: 31.873549ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 569294, last_update: Instant { tv_sec: 541, tv_nsec: 480447663 }, next_time: Instant { tv_sec: 541, tv_nsec: 480447703 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=None last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=31.873549ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=5 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-09-12T05:03:41.482604132Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Handshake version=1 dcid=9e3c81c4bb3acff6 scid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 len=45 pn=49 [2025-09-12T05:03:41.482608149Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=40 blocks=[0..0] ecn_counts=None [2025-09-12T05:03:41.482611666Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm CRYPTO off=0 len=36 [2025-09-12T05:03:41.482621173Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=76.736193ms latest_rtt=31.873549ms srtt=32.606153ms min_rtt=31.873549ms rttvar=12.475869ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=11983 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1616, delivered_time: Instant { tv_sec: 541, tv_nsec: 480564050 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, end_of_app_limited: 10, last_sent_packet: 49, largest_acked: 4, rate_sample: RateSample { bandwidth: 390.73 Kbps, is_app_limited: true, interval: 33.086423ms, delivered: 1616, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 447477627 }), send_elapsed: 1.212874ms, ack_elapsed: 33.086423ms, rtt: 31.873549ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 569294, last_update: Instant { tv_sec: 541, tv_nsec: 480625094 }, next_time: Instant { tv_sec: 541, tv_nsec: 480447703 }, max_datagram_size: 1350, last_packet_size: None, iv: 173.9µs, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.482635099Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 dropped epoch 0 state [2025-09-12T05:03:41.482649837Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=1165 pn=50 [2025-09-12T05:03:41.482653293Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=17 blocks=[0..1] ecn_counts=None [2025-09-12T05:03:41.482656659Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[1f, 27, 10, 2d, e6, 0e, b1, ef, 1a, 61, dd, df, 84, 2f, 99, de, 69, f1, 5f, 1a] reset_token=[1c, 3f, ea, df, bf, ad, 09, ff, c4, 0d, e3, 91, 97, 45, 54, a1] [2025-09-12T05:03:41.482664083Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[3f, 5f, 1b, bc, 69, 82, 51, a3, 6a, f0, b6, d0, e2, 8e, 46, 4c, 99, 79, 76, ee] reset_token=[f2, 47, f4, c6, 83, 21, 13, 15, 79, bb, 38, e7, fb, 10, ea, 5e] [2025-09-12T05:03:41.482670415Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[58, 40, 11, b6, f8, 1c, 7a, 5f, f8, 25, 11, 7c, ee, 21, ec, 9f, eb, 7f, 14, 29] reset_token=[41, d1, 70, 9c, a2, 49, ac, ce, 3a, d0, ba, cf, 5b, 5e, f2, 4b] [2025-09-12T05:03:41.482676577Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[0b, b7, f8, 04, 1f, f8, 8c, db, f1, 30, 03, 9f, 80, 87, e1, 99, a1, ae, 74, 2a] reset_token=[8e, 9a, c2, 11, 74, 61, 7b, 2e, 23, bd, ec, 8f, 77, c1, ca, 07] [2025-09-12T05:03:41.482683239Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=140 off=157 len=100 fin=true [2025-09-12T05:03:41.482686605Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm PADDING len=893 [2025-09-12T05:03:41.482696073Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=82.370429ms latest_rtt=31.873549ms srtt=32.606153ms min_rtt=31.873549ms rttvar=12.475869ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=13174 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1616, delivered_time: Instant { tv_sec: 541, tv_nsec: 480564050 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, end_of_app_limited: 10, last_sent_packet: 50, largest_acked: 4, rate_sample: RateSample { bandwidth: 390.73 Kbps, is_app_limited: true, interval: 33.086423ms, delivered: 1616, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 447477627 }), send_elapsed: 1.212874ms, ack_elapsed: 33.086423ms, rtt: 31.873549ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 1191, rate: 569294, last_update: Instant { tv_sec: 541, tv_nsec: 480625094 }, next_time: Instant { tv_sec: 541, tv_nsec: 480798994 }, max_datagram_size: 1350, last_packet_size: Some(1191), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.482749693Z TRACE quiche_apps::client] written 1350 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.482765162Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=30 pn=51 [2025-09-12T05:03:41.482771213Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm STREAM id=124 off=234 len=23 fin=true [2025-09-12T05:03:41.482783677Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=82.282204ms latest_rtt=31.873549ms srtt=32.606153ms min_rtt=31.873549ms rttvar=12.475869ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=13230 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1616, delivered_time: Instant { tv_sec: 541, tv_nsec: 480564050 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 448690501 }, end_of_app_limited: 10, last_sent_packet: 51, largest_acked: 4, rate_sample: RateSample { bandwidth: 390.73 Kbps, is_app_limited: true, interval: 33.086423ms, delivered: 1616, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 447477627 }), send_elapsed: 1.212874ms, ack_elapsed: 33.086423ms, rtt: 31.873549ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 569294, last_update: Instant { tv_sec: 541, tv_nsec: 480825709 }, next_time: Instant { tv_sec: 541, tv_nsec: 480798994 }, max_datagram_size: 1350, last_packet_size: None, iv: 2.190432ms, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.482829653Z TRACE quiche_apps::client] written 56 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.482839250Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.483045075Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.483052789Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=2 [2025-09-12T05:03:41.483058640Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=2 blocks=[1..8] ecn_counts=None [2025-09-12T05:03:41.483062056Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 5 [2025-09-12T05:03:41.483064411Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 6 [2025-09-12T05:03:41.483066825Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 7 [2025-09-12T05:03:41.483069029Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 8 [2025-09-12T05:03:41.483085550Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.483089407Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.483091822Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.483096030Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.483981663Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.483988977Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=3 [2025-09-12T05:03:41.483994126Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=2 blocks=[1..12] ecn_counts=None [2025-09-12T05:03:41.483997312Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 9 [2025-09-12T05:03:41.483999647Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 10 [2025-09-12T05:03:41.484001831Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 11 [2025-09-12T05:03:41.484003985Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 12 [2025-09-12T05:03:41.484013342Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.484016718Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.484018993Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.484022680Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.485008770Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.485014491Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=4 [2025-09-12T05:03:41.485018849Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=3 blocks=[1..16] ecn_counts=None [2025-09-12T05:03:41.485021755Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 13 [2025-09-12T05:03:41.485024079Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 14 [2025-09-12T05:03:41.485026223Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 15 [2025-09-12T05:03:41.485028357Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 16 [2025-09-12T05:03:41.485036572Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.485039799Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.485042063Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.485045589Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.485994130Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.485999570Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=5 [2025-09-12T05:03:41.486003808Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=2 blocks=[1..20] ecn_counts=None [2025-09-12T05:03:41.486006543Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 17 [2025-09-12T05:03:41.486008817Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 18 [2025-09-12T05:03:41.486011001Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 19 [2025-09-12T05:03:41.486013115Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 20 [2025-09-12T05:03:41.486025919Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.486029326Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.486031590Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.486035197Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.486975933Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.486981724Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=6 [2025-09-12T05:03:41.486986092Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=2 blocks=[1..24] ecn_counts=None [2025-09-12T05:03:41.486989037Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 21 [2025-09-12T05:03:41.486991311Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 22 [2025-09-12T05:03:41.486993466Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 23 [2025-09-12T05:03:41.486995590Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 24 [2025-09-12T05:03:41.487003674Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.487006951Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.487009225Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.487012701Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.487948368Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.487955942Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=7 [2025-09-12T05:03:41.487960340Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=1 blocks=[1..28] ecn_counts=None [2025-09-12T05:03:41.487963176Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 25 [2025-09-12T05:03:41.487965430Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 26 [2025-09-12T05:03:41.487967574Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 27 [2025-09-12T05:03:41.487969698Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 28 [2025-09-12T05:03:41.487988353Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.487991869Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.487994183Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.487997990Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.488955478Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.488961128Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=8 [2025-09-12T05:03:41.488965557Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=3 blocks=[1..32] ecn_counts=None [2025-09-12T05:03:41.488968422Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 29 [2025-09-12T05:03:41.488970646Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 30 [2025-09-12T05:03:41.488972800Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 31 [2025-09-12T05:03:41.488974924Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 32 [2025-09-12T05:03:41.488987327Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.488990714Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.488992998Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.488996615Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.489922012Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.489925769Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=9 [2025-09-12T05:03:41.489929967Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=2 blocks=[1..36] ecn_counts=None [2025-09-12T05:03:41.489952389Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 33 [2025-09-12T05:03:41.489958550Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 34 [2025-09-12T05:03:41.489960815Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 35 [2025-09-12T05:03:41.489962949Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 36 [2025-09-12T05:03:41.489972326Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.489975873Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.489978137Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.489981994Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.490859502Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.490863490Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=10 [2025-09-12T05:03:41.490868118Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=3 blocks=[1..40] ecn_counts=None [2025-09-12T05:03:41.490871054Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 37 [2025-09-12T05:03:41.490873258Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 38 [2025-09-12T05:03:41.490875432Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 39 [2025-09-12T05:03:41.490877586Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 40 [2025-09-12T05:03:41.490885892Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.490889278Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.490891572Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.490895069Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.491796561Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.491802192Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=670e0a7def303f1a24b9e2f5f86ec124fb4167c5 key_phase=false len=22 pn=11 [2025-09-12T05:03:41.491806450Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=2 blocks=[1..47] ecn_counts=None [2025-09-12T05:03:41.491809245Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 41 [2025-09-12T05:03:41.491811449Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 42 [2025-09-12T05:03:41.491813603Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 43 [2025-09-12T05:03:41.491815747Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 44 [2025-09-12T05:03:41.491823121Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 45 [2025-09-12T05:03:41.491826698Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 46 [2025-09-12T05:03:41.491828882Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 47 [2025-09-12T05:03:41.491839452Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.491842848Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.491845102Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.491848689Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.514633722Z TRACE quiche_apps::client] got 408 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.514649551Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=387 pn=12 [2025-09-12T05:03:41.514657827Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 path ID 0 now see SCID with seq num 1 [2025-09-12T05:03:41.514662295Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm HANDSHAKE_DONE [2025-09-12T05:03:41.514667274Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 dropped epoch 1 state [2025-09-12T05:03:41.514671352Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm ACK delay=12 blocks=[5..47, 50..51] ecn_counts=None [2025-09-12T05:03:41.514676331Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 50 [2025-09-12T05:03:41.514679808Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 packet newly acked 51 [2025-09-12T05:03:41.514686229Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm CRYPTO off=0 len=356 [2025-09-12T05:03:41.514718129Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm RETIRE_CONNECTION_ID seq_num=0 [2025-09-12T05:03:41.514735121Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 408 bytes [2025-09-12T05:03:41.514740521Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.514743737Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.514747083Z INFO quiche_apps::client] Retiring source CID 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 [2025-09-12T05:03:41.514766619Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=45 pn=52 [2025-09-12T05:03:41.514770717Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=14 blocks=[2..12] ecn_counts=None [2025-09-12T05:03:41.514774654Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=1 conn_id=[d2, 45, ec, 78, b8, b2, 3f, ca, c5, 6a, 01, 2f, 3c, 91, 7e, 91, 1c, 68, c7, f3] reset_token=[98, f1, 0f, 2e, 17, 2b, a6, aa, 8d, a0, 64, 66, de, e7, b3, 90] [2025-09-12T05:03:41.514788571Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=76.913236ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 52, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 71, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 512823409 }, next_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, max_datagram_size: 1350, last_packet_size: Some(71), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.514847180Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.514857870Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.516053492Z TRACE quiche_apps::client] got 250 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.516061276Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=229 pn=13 [2025-09-12T05:03:41.516067107Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=12 off=0 len=32 fin=true [2025-09-12T05:03:41.516070504Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=4 off=0 len=32 fin=true [2025-09-12T05:03:41.516073259Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=0 off=0 len=32 fin=true [2025-09-12T05:03:41.516076274Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=152 off=0 len=32 fin=true [2025-09-12T05:03:41.516079440Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=8 off=0 len=32 fin=false [2025-09-12T05:03:41.516082085Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=84 off=0 len=32 fin=false [2025-09-12T05:03:41.516089639Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 250 bytes [2025-09-12T05:03:41.516093667Z TRACE quiche_apps::client] got 42 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.516096482Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=21 pn=14 [2025-09-12T05:03:41.516100079Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=8 off=32 len=0 fin=true [2025-09-12T05:03:41.516104517Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 42 bytes [2025-09-12T05:03:41.516107903Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.516110298Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.516115277Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516117581Z TRACE quiche_apps::common] stream 12 has 32 bytes (fin? true) [2025-09-12T05:03:41.516119946Z DEBUG quiche_apps::common] 1/39 responses received [2025-09-12T05:03:41.516123432Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516125676Z TRACE quiche_apps::common] stream 4 has 32 bytes (fin? true) [2025-09-12T05:03:41.516127840Z DEBUG quiche_apps::common] 2/39 responses received [2025-09-12T05:03:41.516131077Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516133241Z TRACE quiche_apps::common] stream 0 has 32 bytes (fin? true) [2025-09-12T05:03:41.516135395Z DEBUG quiche_apps::common] 3/39 responses received [2025-09-12T05:03:41.516138621Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516140785Z TRACE quiche_apps::common] stream 152 has 32 bytes (fin? true) [2025-09-12T05:03:41.516143149Z DEBUG quiche_apps::common] 4/39 responses received [2025-09-12T05:03:41.516146145Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516148309Z TRACE quiche_apps::common] stream 8 has 32 bytes (fin? true) [2025-09-12T05:03:41.516150473Z DEBUG quiche_apps::common] 5/39 responses received [2025-09-12T05:03:41.516153468Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516155612Z TRACE quiche_apps::common] stream 84 has 32 bytes (fin? false) [2025-09-12T05:03:41.516162245Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=53 [2025-09-12T05:03:41.516164829Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=8 blocks=[2..14] ecn_counts=None [2025-09-12T05:03:41.516175650Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=75.526407ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 53, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, max_datagram_size: 1350, last_packet_size: None, iv: 135.323µs, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.516209593Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.516216887Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.516227016Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.516232185Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=22 pn=15 [2025-09-12T05:03:41.516240230Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=84 off=32 len=0 fin=true [2025-09-12T05:03:41.516248175Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.516251642Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.516253936Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.516258194Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.516260478Z TRACE quiche_apps::common] stream 84 has 0 bytes (fin? true) [2025-09-12T05:03:41.516262763Z DEBUG quiche_apps::common] 6/39 responses received [2025-09-12T05:03:41.516268884Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=54 [2025-09-12T05:03:41.516271419Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..15] ecn_counts=None [2025-09-12T05:03:41.516277219Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=75.424868ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 54, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.516312355Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.516319088Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.516464509Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.516468907Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=16 [2025-09-12T05:03:41.516474057Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=88 off=0 len=32 fin=false [2025-09-12T05:03:41.516492271Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.516495787Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.516498072Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.516502049Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516504253Z TRACE quiche_apps::common] stream 88 has 32 bytes (fin? false) [2025-09-12T05:03:41.516511076Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=55 [2025-09-12T05:03:41.516513581Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=5 blocks=[2..16] ecn_counts=None [2025-09-12T05:03:41.516519612Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=75.182495ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 55, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.516550920Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.516558094Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.516835481Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.516840190Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=17 [2025-09-12T05:03:41.516845130Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=80 off=0 len=32 fin=false [2025-09-12T05:03:41.516851281Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.516854557Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.516856872Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.516860538Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.516862742Z TRACE quiche_apps::common] stream 80 has 32 bytes (fin? false) [2025-09-12T05:03:41.516869104Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=56 [2025-09-12T05:03:41.516871599Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=3 blocks=[2..17] ecn_counts=None [2025-09-12T05:03:41.516881968Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=74.820109ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 56, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.516913036Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.516920119Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.516979231Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.516989170Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=18 [2025-09-12T05:03:41.516994921Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=16 off=0 len=32 fin=false [2025-09-12T05:03:41.517001804Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.517005761Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517008546Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=19 [2025-09-12T05:03:41.517012023Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=44 off=0 len=32 fin=false [2025-09-12T05:03:41.517015930Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.517019096Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.517021410Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.517025357Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517027562Z TRACE quiche_apps::common] stream 16 has 32 bytes (fin? false) [2025-09-12T05:03:41.517030727Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517032912Z TRACE quiche_apps::common] stream 44 has 32 bytes (fin? false) [2025-09-12T05:03:41.517039815Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=57 [2025-09-12T05:03:41.517042349Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=3 blocks=[2..19] ecn_counts=None [2025-09-12T05:03:41.517048180Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=74.653917ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 57, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.517086502Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.517093795Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.517142917Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517147636Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=20 [2025-09-12T05:03:41.517152665Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=24 off=0 len=32 fin=false [2025-09-12T05:03:41.517159087Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.517162924Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517165659Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=21 [2025-09-12T05:03:41.517169046Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=104 off=0 len=32 fin=false [2025-09-12T05:03:41.517172953Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.517176079Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.517178353Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.517182010Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517184224Z TRACE quiche_apps::common] stream 24 has 32 bytes (fin? false) [2025-09-12T05:03:41.517187240Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517189414Z TRACE quiche_apps::common] stream 104 has 32 bytes (fin? false) [2025-09-12T05:03:41.517195695Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=58 [2025-09-12T05:03:41.517198170Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=3 blocks=[2..21] ecn_counts=None [2025-09-12T05:03:41.517203761Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=74.498306ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 58, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.517234408Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.517247743Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.517278520Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517282868Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=22 pn=22 [2025-09-12T05:03:41.517287888Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=88 off=32 len=0 fin=true [2025-09-12T05:03:41.517294530Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.517298357Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517301062Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=23 [2025-09-12T05:03:41.517304579Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=20 off=0 len=32 fin=false [2025-09-12T05:03:41.517308847Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.517311972Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.517314287Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.517318535Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.517320779Z TRACE quiche_apps::common] stream 88 has 0 bytes (fin? true) [2025-09-12T05:03:41.517323073Z DEBUG quiche_apps::common] 7/39 responses received [2025-09-12T05:03:41.517326209Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517328353Z TRACE quiche_apps::common] stream 20 has 32 bytes (fin? false) [2025-09-12T05:03:41.517334645Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=59 [2025-09-12T05:03:41.517337079Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..23] ecn_counts=None [2025-09-12T05:03:41.517342780Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=74.359307ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 59, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.517373227Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.517380290Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.517525431Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517529919Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=24 [2025-09-12T05:03:41.517534739Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=48 off=0 len=32 fin=false [2025-09-12T05:03:41.517540820Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.517548644Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.517551029Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.517554616Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517556800Z TRACE quiche_apps::common] stream 48 has 32 bytes (fin? false) [2025-09-12T05:03:41.517563091Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=60 [2025-09-12T05:03:41.517565626Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..24] ecn_counts=None [2025-09-12T05:03:41.517571247Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=74.13082ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 60, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.517601753Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.517608657Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.517618194Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517623033Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=25 [2025-09-12T05:03:41.517630788Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=52 off=0 len=32 fin=false [2025-09-12T05:03:41.517638612Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.517642610Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517645325Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=26 [2025-09-12T05:03:41.517648791Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=92 off=0 len=32 fin=false [2025-09-12T05:03:41.517652628Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.517655794Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.517658079Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.517661575Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517663789Z TRACE quiche_apps::common] stream 52 has 32 bytes (fin? false) [2025-09-12T05:03:41.517666915Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517669069Z TRACE quiche_apps::common] stream 92 has 32 bytes (fin? false) [2025-09-12T05:03:41.517675150Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=61 [2025-09-12T05:03:41.517677575Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=3 blocks=[2..26] ecn_counts=None [2025-09-12T05:03:41.517682975Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=74.019142ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 61, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.517717309Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.517723932Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.517748067Z TRACE quiche_apps::client] got 78 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517752074Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=57 pn=27 [2025-09-12T05:03:41.517756773Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=44 off=32 len=0 fin=true [2025-09-12T05:03:41.517760129Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=116 off=0 len=32 fin=false [2025-09-12T05:03:41.517766301Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 78 bytes [2025-09-12T05:03:41.517769577Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.517771921Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.517776440Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.517778684Z TRACE quiche_apps::common] stream 44 has 0 bytes (fin? true) [2025-09-12T05:03:41.517780898Z DEBUG quiche_apps::common] 8/39 responses received [2025-09-12T05:03:41.517783934Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.517786088Z TRACE quiche_apps::common] stream 116 has 32 bytes (fin? false) [2025-09-12T05:03:41.517792229Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=62 [2025-09-12T05:03:41.517794704Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..27] ecn_counts=None [2025-09-12T05:03:41.517800284Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.901793ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 62, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.517834458Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.517841401Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.517851339Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517856569Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=22 pn=28 [2025-09-12T05:03:41.517864183Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=80 off=32 len=0 fin=true [2025-09-12T05:03:41.517871667Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.517875004Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.517877318Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.517881386Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.517883630Z TRACE quiche_apps::common] stream 80 has 0 bytes (fin? true) [2025-09-12T05:03:41.517885874Z DEBUG quiche_apps::common] 9/39 responses received [2025-09-12T05:03:41.517892025Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=63 [2025-09-12T05:03:41.517894480Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..28] ecn_counts=None [2025-09-12T05:03:41.517900081Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.802017ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 63, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.517929375Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.517958219Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.517968819Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517973788Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=29 [2025-09-12T05:03:41.517978968Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=60 off=0 len=32 fin=false [2025-09-12T05:03:41.517985129Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.517988846Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.517991541Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=30 [2025-09-12T05:03:41.517994898Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=120 off=0 len=32 fin=false [2025-09-12T05:03:41.518003514Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.518006720Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518008994Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518012631Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518014935Z TRACE quiche_apps::common] stream 60 has 32 bytes (fin? false) [2025-09-12T05:03:41.518018101Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518020275Z TRACE quiche_apps::common] stream 120 has 32 bytes (fin? false) [2025-09-12T05:03:41.518026717Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=64 [2025-09-12T05:03:41.518029292Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..30] ecn_counts=None [2025-09-12T05:03:41.518034962Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.667115ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 64, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518066010Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518072923Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518090967Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518096417Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=31 [2025-09-12T05:03:41.518101246Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=32 off=0 len=32 fin=false [2025-09-12T05:03:41.518119139Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.518122536Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518124870Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518128507Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518130751Z TRACE quiche_apps::common] stream 32 has 32 bytes (fin? false) [2025-09-12T05:03:41.518137283Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=65 [2025-09-12T05:03:41.518139818Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=5 blocks=[2..31] ecn_counts=None [2025-09-12T05:03:41.518145679Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.556398ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 65, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518179562Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518186846Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518235456Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518239925Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=32 [2025-09-12T05:03:41.518244994Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=96 off=0 len=32 fin=false [2025-09-12T05:03:41.518251376Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.518254622Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518256887Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518260433Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518262647Z TRACE quiche_apps::common] stream 96 has 32 bytes (fin? false) [2025-09-12T05:03:41.518268849Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=66 [2025-09-12T05:03:41.518271323Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=3 blocks=[2..32] ecn_counts=None [2025-09-12T05:03:41.518276884Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.425223ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 66, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518306469Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518312961Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518322269Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518327148Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=33 [2025-09-12T05:03:41.518334642Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=108 off=0 len=32 fin=false [2025-09-12T05:03:41.518345542Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.518348958Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518351243Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518354769Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518356983Z TRACE quiche_apps::common] stream 108 has 32 bytes (fin? false) [2025-09-12T05:03:41.518363175Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=67 [2025-09-12T05:03:41.518365639Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..33] ecn_counts=None [2025-09-12T05:03:41.518371160Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.330897ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 67, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518400996Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518407798Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518460627Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518465165Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=34 [2025-09-12T05:03:41.518470085Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=100 off=0 len=32 fin=false [2025-09-12T05:03:41.518476296Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.518480143Z TRACE quiche_apps::client] got 42 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518482878Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=21 pn=35 [2025-09-12T05:03:41.518486255Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=24 off=32 len=0 fin=true [2025-09-12T05:03:41.518490402Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 42 bytes [2025-09-12T05:03:41.518493568Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518495862Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518499540Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518501724Z TRACE quiche_apps::common] stream 100 has 32 bytes (fin? false) [2025-09-12T05:03:41.518505641Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.518507845Z TRACE quiche_apps::common] stream 24 has 0 bytes (fin? true) [2025-09-12T05:03:41.518510059Z DEBUG quiche_apps::common] 10/39 responses received [2025-09-12T05:03:41.518516070Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=68 [2025-09-12T05:03:41.518523003Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=4 blocks=[2..35] ecn_counts=None [2025-09-12T05:03:41.518528714Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.173403ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 68, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518559251Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518566074Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518575752Z TRACE quiche_apps::client] got 46 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518580961Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=25 pn=36 [2025-09-12T05:03:41.518588445Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=16 off=32 len=0 fin=true [2025-09-12T05:03:41.518593144Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=20 off=32 len=0 fin=true [2025-09-12T05:03:41.518599275Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 46 bytes [2025-09-12T05:03:41.518602582Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518604916Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518609034Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.518611268Z TRACE quiche_apps::common] stream 16 has 0 bytes (fin? true) [2025-09-12T05:03:41.518613502Z DEBUG quiche_apps::common] 11/39 responses received [2025-09-12T05:03:41.518616708Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.518618892Z TRACE quiche_apps::common] stream 20 has 0 bytes (fin? true) [2025-09-12T05:03:41.518621036Z DEBUG quiche_apps::common] 12/39 responses received [2025-09-12T05:03:41.518627087Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=69 [2025-09-12T05:03:41.518629542Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=5 blocks=[2..36] ecn_counts=None [2025-09-12T05:03:41.518634932Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=73.067125ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 69, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518668795Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518675337Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518684775Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518690095Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=37 [2025-09-12T05:03:41.518697759Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=28 off=0 len=32 fin=false [2025-09-12T05:03:41.518703781Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.518707698Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518710433Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=38 [2025-09-12T05:03:41.518713779Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=112 off=0 len=32 fin=false [2025-09-12T05:03:41.518717536Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.518720702Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518722977Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518726523Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518728737Z TRACE quiche_apps::common] stream 28 has 32 bytes (fin? false) [2025-09-12T05:03:41.518731863Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518734037Z TRACE quiche_apps::common] stream 112 has 32 bytes (fin? false) [2025-09-12T05:03:41.518739978Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=70 [2025-09-12T05:03:41.518742433Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=3 blocks=[2..38] ecn_counts=None [2025-09-12T05:03:41.518747933Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=72.954164ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 70, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518777318Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518784191Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518800061Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518805110Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=22 pn=39 [2025-09-12T05:03:41.518809808Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=116 off=32 len=0 fin=true [2025-09-12T05:03:41.518816160Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 43 bytes [2025-09-12T05:03:41.518819967Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518822683Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=52 pn=40 [2025-09-12T05:03:41.518826239Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=40 off=0 len=32 fin=false [2025-09-12T05:03:41.518830106Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 73 bytes [2025-09-12T05:03:41.518833262Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518835516Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518839704Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.518841908Z TRACE quiche_apps::common] stream 116 has 0 bytes (fin? true) [2025-09-12T05:03:41.518844233Z DEBUG quiche_apps::common] 13/39 responses received [2025-09-12T05:03:41.518847289Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518849473Z TRACE quiche_apps::common] stream 40 has 32 bytes (fin? false) [2025-09-12T05:03:41.518855424Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=71 [2025-09-12T05:03:41.518857929Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=3 blocks=[2..40] ecn_counts=None [2025-09-12T05:03:41.518863449Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=72.838628ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 71, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.518893405Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.518900157Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.518923992Z TRACE quiche_apps::client] got 74 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.518927929Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=53 pn=41 [2025-09-12T05:03:41.518950070Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=72 off=0 len=32 fin=false [2025-09-12T05:03:41.518961251Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 74 bytes [2025-09-12T05:03:41.518964848Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.518971621Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.518975368Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.518977652Z TRACE quiche_apps::common] stream 72 has 32 bytes (fin? false) [2025-09-12T05:03:41.518984545Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=5 pn=72 [2025-09-12T05:03:41.518987090Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm ACK delay=7 blocks=[2..41] ecn_counts=None [2025-09-12T05:03:41.518992981Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=72.709086ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=71 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 51, last_sent_packet: 72, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 514226819 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.519023918Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.519030160Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.519420348Z TRACE quiche_apps::client] got 532 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.519424937Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=511 pn=42 [2025-09-12T05:03:41.519430167Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=36 off=0 len=32 fin=false [2025-09-12T05:03:41.519433643Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=60 off=32 len=0 fin=true [2025-09-12T05:03:41.519436428Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=104 off=32 len=0 fin=true [2025-09-12T05:03:41.519439073Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=28 off=32 len=0 fin=true [2025-09-12T05:03:41.519442089Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=128 off=0 len=32 fin=true [2025-09-12T05:03:41.519445074Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=108 off=32 len=0 fin=true [2025-09-12T05:03:41.519447750Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=136 off=0 len=32 fin=true [2025-09-12T05:03:41.519450314Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=124 off=0 len=32 fin=true [2025-09-12T05:03:41.519453821Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=112 off=32 len=0 fin=true [2025-09-12T05:03:41.519456436Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=40 off=32 len=0 fin=true [2025-09-12T05:03:41.519459051Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=72 off=32 len=0 fin=true [2025-09-12T05:03:41.519461725Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=132 off=0 len=32 fin=true [2025-09-12T05:03:41.519464320Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=148 off=0 len=32 fin=true [2025-09-12T05:03:41.519471474Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=56 off=0 len=32 fin=false [2025-09-12T05:03:41.519474259Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=100 off=32 len=0 fin=true [2025-09-12T05:03:41.519476934Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=68 off=0 len=32 fin=true [2025-09-12T05:03:41.519479930Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=64 off=0 len=32 fin=true [2025-09-12T05:03:41.519482624Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=76 off=0 len=32 fin=true [2025-09-12T05:03:41.519485219Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=144 off=0 len=32 fin=true [2025-09-12T05:03:41.519487824Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=52 off=32 len=0 fin=true [2025-09-12T05:03:41.519490439Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=48 off=32 len=0 fin=true [2025-09-12T05:03:41.519492974Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=92 off=32 len=0 fin=true [2025-09-12T05:03:41.519495569Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=96 off=32 len=0 fin=true [2025-09-12T05:03:41.519498144Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=32 off=32 len=0 fin=true [2025-09-12T05:03:41.519500769Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=140 off=0 len=32 fin=true [2025-09-12T05:03:41.519503383Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=120 off=32 len=0 fin=true [2025-09-12T05:03:41.519514885Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 532 bytes [2025-09-12T05:03:41.519518972Z TRACE quiche_apps::client] got 42 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.519521737Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=21 pn=43 [2025-09-12T05:03:41.519525404Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=56 off=32 len=0 fin=true [2025-09-12T05:03:41.519539300Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 42 bytes [2025-09-12T05:03:41.519543088Z TRACE quiche_apps::client] got 42 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.519545813Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx pkt Short dcid=1f27102de60eb1ef1a61dddf842f99de69f15f1a key_phase=false len=21 pn=44 [2025-09-12T05:03:41.519549299Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 rx frm STREAM id=36 off=32 len=0 fin=true [2025-09-12T05:03:41.519553206Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 42 bytes [2025-09-12T05:03:41.519556352Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.519558637Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.519563916Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519566160Z TRACE quiche_apps::common] stream 36 has 32 bytes (fin? true) [2025-09-12T05:03:41.519568425Z DEBUG quiche_apps::common] 14/39 responses received [2025-09-12T05:03:41.519572042Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519574215Z TRACE quiche_apps::common] stream 60 has 0 bytes (fin? true) [2025-09-12T05:03:41.519576450Z DEBUG quiche_apps::common] 15/39 responses received [2025-09-12T05:03:41.519579696Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519581870Z TRACE quiche_apps::common] stream 104 has 0 bytes (fin? true) [2025-09-12T05:03:41.519584064Z DEBUG quiche_apps::common] 16/39 responses received [2025-09-12T05:03:41.519587110Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519589274Z TRACE quiche_apps::common] stream 28 has 0 bytes (fin? true) [2025-09-12T05:03:41.519591418Z DEBUG quiche_apps::common] 17/39 responses received [2025-09-12T05:03:41.519594624Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519599443Z TRACE quiche_apps::common] stream 128 has 32 bytes (fin? true) [2025-09-12T05:03:41.519601757Z DEBUG quiche_apps::common] 18/39 responses received [2025-09-12T05:03:41.519604792Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519606957Z TRACE quiche_apps::common] stream 108 has 0 bytes (fin? true) [2025-09-12T05:03:41.519609131Z DEBUG quiche_apps::common] 19/39 responses received [2025-09-12T05:03:41.519612317Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519614491Z TRACE quiche_apps::common] stream 136 has 32 bytes (fin? true) [2025-09-12T05:03:41.519616755Z DEBUG quiche_apps::common] 20/39 responses received [2025-09-12T05:03:41.519619801Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519621995Z TRACE quiche_apps::common] stream 124 has 32 bytes (fin? true) [2025-09-12T05:03:41.519624149Z DEBUG quiche_apps::common] 21/39 responses received [2025-09-12T05:03:41.519627214Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519629378Z TRACE quiche_apps::common] stream 112 has 0 bytes (fin? true) [2025-09-12T05:03:41.519631542Z DEBUG quiche_apps::common] 22/39 responses received [2025-09-12T05:03:41.519634488Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519636642Z TRACE quiche_apps::common] stream 40 has 0 bytes (fin? true) [2025-09-12T05:03:41.519638776Z DEBUG quiche_apps::common] 23/39 responses received [2025-09-12T05:03:41.519641782Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519643926Z TRACE quiche_apps::common] stream 72 has 0 bytes (fin? true) [2025-09-12T05:03:41.519646090Z DEBUG quiche_apps::common] 24/39 responses received [2025-09-12T05:03:41.519649115Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519651269Z TRACE quiche_apps::common] stream 132 has 32 bytes (fin? true) [2025-09-12T05:03:41.519653454Z DEBUG quiche_apps::common] 25/39 responses received [2025-09-12T05:03:41.519656660Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519658824Z TRACE quiche_apps::common] stream 148 has 32 bytes (fin? true) [2025-09-12T05:03:41.519661088Z DEBUG quiche_apps::common] 26/39 responses received [2025-09-12T05:03:41.519664143Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519666307Z TRACE quiche_apps::common] stream 56 has 32 bytes (fin? true) [2025-09-12T05:03:41.519668491Z DEBUG quiche_apps::common] 27/39 responses received [2025-09-12T05:03:41.519671517Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519673661Z TRACE quiche_apps::common] stream 100 has 0 bytes (fin? true) [2025-09-12T05:03:41.519675825Z DEBUG quiche_apps::common] 28/39 responses received [2025-09-12T05:03:41.519679211Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519681375Z TRACE quiche_apps::common] stream 68 has 32 bytes (fin? true) [2025-09-12T05:03:41.519683550Z DEBUG quiche_apps::common] 29/39 responses received [2025-09-12T05:03:41.519686676Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519688809Z TRACE quiche_apps::common] stream 64 has 32 bytes (fin? true) [2025-09-12T05:03:41.519690953Z DEBUG quiche_apps::common] 30/39 responses received [2025-09-12T05:03:41.519693929Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519696073Z TRACE quiche_apps::common] stream 76 has 32 bytes (fin? true) [2025-09-12T05:03:41.519698227Z DEBUG quiche_apps::common] 31/39 responses received [2025-09-12T05:03:41.519701303Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519703447Z TRACE quiche_apps::common] stream 144 has 32 bytes (fin? true) [2025-09-12T05:03:41.519705691Z DEBUG quiche_apps::common] 32/39 responses received [2025-09-12T05:03:41.519708646Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519710801Z TRACE quiche_apps::common] stream 52 has 0 bytes (fin? true) [2025-09-12T05:03:41.519712945Z DEBUG quiche_apps::common] 33/39 responses received [2025-09-12T05:03:41.519715890Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519718044Z TRACE quiche_apps::common] stream 48 has 0 bytes (fin? true) [2025-09-12T05:03:41.519722693Z DEBUG quiche_apps::common] 34/39 responses received [2025-09-12T05:03:41.519725809Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519727973Z TRACE quiche_apps::common] stream 92 has 0 bytes (fin? true) [2025-09-12T05:03:41.519730157Z DEBUG quiche_apps::common] 35/39 responses received [2025-09-12T05:03:41.519733162Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519735306Z TRACE quiche_apps::common] stream 96 has 0 bytes (fin? true) [2025-09-12T05:03:41.519737470Z DEBUG quiche_apps::common] 36/39 responses received [2025-09-12T05:03:41.519740416Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519742540Z TRACE quiche_apps::common] stream 32 has 0 bytes (fin? true) [2025-09-12T05:03:41.519744674Z DEBUG quiche_apps::common] 37/39 responses received [2025-09-12T05:03:41.519747679Z TRACE quiche_apps::common] received 32 bytes [2025-09-12T05:03:41.519749823Z TRACE quiche_apps::common] stream 140 has 32 bytes (fin? true) [2025-09-12T05:03:41.519752007Z DEBUG quiche_apps::common] 38/39 responses received [2025-09-12T05:03:41.519754943Z TRACE quiche_apps::common] received 0 bytes [2025-09-12T05:03:41.519757077Z TRACE quiche_apps::common] stream 120 has 0 bytes (fin? true) [2025-09-12T05:03:41.519759241Z DEBUG quiche_apps::common] 39/39 responses received [2025-09-12T05:03:41.519761395Z INFO quiche_apps::common] 39/39 response(s) received in 70.223009ms, closing... [2025-09-12T05:03:41.519767897Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx pkt Short dcid=9e3c81c4bb3acff6 key_phase=false len=10 pn=73 [2025-09-12T05:03:41.519770432Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 tx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65] [2025-09-12T05:03:41.519776844Z TRACE quiche::recovery::congestion::recovery] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 timer=76.935036ms latest_rtt=31.916534ms srtt=35.379181ms min_rtt=31.873549ms rttvar=4.141912ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=107 app_limited=true congestion_recovery_start_time=None Rate { delivered: 14747, delivered_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, first_sent_time: Instant { tv_sec: 541, tv_nsec: 515013841 }, end_of_app_limited: 72, last_sent_packet: 73, largest_acked: 51, rate_sample: RateSample { bandwidth: 3.27 Mbps, is_app_limited: true, interval: 32.151478ms, delivered: 13131, prior_delivered: 1616, prior_time: Some(Instant { tv_sec: 541, tv_nsec: 480564050 }), send_elapsed: 32.108493ms, ack_elapsed: 32.151478ms, rtt: 31.916534ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 524672, last_update: Instant { tv_sec: 541, tv_nsec: 517833162 }, next_time: Instant { tv_sec: 541, tv_nsec: 515149164 }, max_datagram_size: 1350, last_packet_size: None, iv: 68.614µs, max_pacing_rate: None } hystart=window_end=Some(49) last_round_min_rtt=31.873549ms 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-09-12T05:03:41.519810106Z TRACE quiche_apps::client] written 36 bytes from 0.0.0.0:56616 to 193.167.100.100:443 [2025-09-12T05:03:41.519816157Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.549325633Z TRACE quiche_apps::client] got 47 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.549339860Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 47 bytes [2025-09-12T05:03:41.549344609Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.549347765Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.549352894Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.550211387Z TRACE quiche_apps::client] got 48 bytes from 193.167.100.100:443 to 0.0.0.0:56616 [2025-09-12T05:03:41.550216727Z TRACE quiche_apps::client] 0.0.0.0:56616: processed 48 bytes [2025-09-12T05:03:41.550224351Z TRACE quiche_apps::client] 0.0.0.0:56616: recv() would block [2025-09-12T05:03:41.550226726Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.550229871Z TRACE quiche_apps::client] 0.0.0.0:56616 -> 193.167.100.100:443: done writing [2025-09-12T05:03:41.676406120Z TRACE quiche_apps::client] timed out [2025-09-12T05:03:41.676420286Z TRACE quiche] 670e0a7def303f1a24b9e2f5f86ec124fb4167c5 draining timeout expired [2025-09-12T05:03:41.676450583Z TRACE quiche_apps::client] done reading [2025-09-12T05:03:41.676457806Z INFO quiche_apps::client] connection closed, recv=47 sent=74 lost=0 retrans=0 sent_bytes=15633 recv_bytes=5031 lost_bytes=0 [local_addr=0.0.0.0:56616 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=47 sent=74 lost=0 retrans=0 rtt=35.379181ms min_rtt=Some(31.873549ms) rttvar=4.141912ms cwnd=14850 sent_bytes=15633 recv_bytes=5031 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=408410]