nixbot

1this derivation will be built:2  /nix/store/xvnaqkkl48pzr171icjk1js2033sjav5-niks3-go-unit-tests.drv3building '/nix/store/xvnaqkkl48pzr171icjk1js2033sjav5-niks3-go-unit-tests.drv' on 'ssh-ng://nix@jamie'4building '/nix/store/xvnaqkkl48pzr171icjk1js2033sjav5-niks3-go-unit-tests.drv'5niks3-go-unit-tests> Running client tests...6niks3-go-unit-tests> === RUN   TestDoServerRequestAttachesToken7niks3-go-unit-tests> === PAUSE TestDoServerRequestAttachesToken8niks3-go-unit-tests> === RUN   TestCaseHackSuffix9niks3-go-unit-tests> === PAUSE TestCaseHackSuffix10niks3-go-unit-tests> === RUN   TestPartSizeForNAR11niks3-go-unit-tests> === PAUSE TestPartSizeForNAR12niks3-go-unit-tests> === RUN   TestUploadMultipart_SupersededByPeer13niks3-go-unit-tests> === PAUSE TestUploadMultipart_SupersededByPeer14niks3-go-unit-tests> === RUN   TestDumpPathMatchesNix15niks3-go-unit-tests> === PAUSE TestDumpPathMatchesNix16niks3-go-unit-tests> === RUN   TestDumpPathSingleFile17niks3-go-unit-tests> === PAUSE TestDumpPathSingleFile18niks3-go-unit-tests> === RUN   TestDumpPathWriterError19niks3-go-unit-tests> === PAUSE TestDumpPathWriterError20niks3-go-unit-tests> === RUN   TestEncodeNixBase3221niks3-go-unit-tests> === PAUSE TestEncodeNixBase3222niks3-go-unit-tests> === RUN   TestEncodeNixBase32WithRealHash23niks3-go-unit-tests> === PAUSE TestEncodeNixBase32WithRealHash24niks3-go-unit-tests> === RUN   TestConvertHashToNix3225niks3-go-unit-tests> === PAUSE TestConvertHashToNix3226niks3-go-unit-tests> === RUN   TestGetStorePathHash27niks3-go-unit-tests> === PAUSE TestGetStorePathHash28niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility29niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility30niks3-go-unit-tests> === RUN   TestParsePathInfoJSON31niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON32niks3-go-unit-tests> === RUN   TestParsePathInfoJSONMultiplePaths33niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths34niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility35niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility36niks3-go-unit-tests> === RUN   TestRateLimiterFeedback37niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback38niks3-go-unit-tests> === RUN   TestRateLimiterFeedback_400DoesNotCountAsSuccess39niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback_400DoesNotCountAsSuccess40niks3-go-unit-tests> === RUN   TestResolveStorePath41niks3-go-unit-tests> === PAUSE TestResolveStorePath42niks3-go-unit-tests> === RUN   TestDoWithRetry_BodyReplayedViaGetBody43niks3-go-unit-tests> === PAUSE TestDoWithRetry_BodyReplayedViaGetBody44niks3-go-unit-tests> === RUN   TestShellSplit45niks3-go-unit-tests> === PAUSE TestShellSplit46niks3-go-unit-tests> === RUN   TestShellSplitErrors47niks3-go-unit-tests> === PAUSE TestShellSplitErrors48niks3-go-unit-tests> === RUN   TestSetClientTLS49niks3-go-unit-tests> === PAUSE TestSetClientTLS50niks3-go-unit-tests> === RUN   TestSetClientTLSDoesNotMutateDefaultTransport51niks3-go-unit-tests> === PAUSE TestSetClientTLSDoesNotMutateDefaultTransport52niks3-go-unit-tests> === RUN   TestSetClientTLSErrors53niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors54niks3-go-unit-tests> === RUN   TestStaticToken55niks3-go-unit-tests> === PAUSE TestStaticToken56niks3-go-unit-tests> === RUN   TestFileTokenReadsAndCaches57niks3-go-unit-tests> === PAUSE TestFileTokenReadsAndCaches58niks3-go-unit-tests> === RUN   TestFileTokenMissing59niks3-go-unit-tests> === PAUSE TestFileTokenMissing60niks3-go-unit-tests> === RUN   TestFileTokenEmpty61niks3-go-unit-tests> === PAUSE TestFileTokenEmpty62niks3-go-unit-tests> === RUN   TestScriptTokenNoExpiryRerunsEveryCall63niks3-go-unit-tests> === PAUSE TestScriptTokenNoExpiryRerunsEveryCall64niks3-go-unit-tests> === RUN   TestScriptTokenCachesUntilRefresh65niks3-go-unit-tests> === PAUSE TestScriptTokenCachesUntilRefresh66niks3-go-unit-tests> === RUN   TestScriptTokenEmptyToken67niks3-go-unit-tests> === PAUSE TestScriptTokenEmptyToken68niks3-go-unit-tests> === RUN   TestScriptTokenBadJSON69niks3-go-unit-tests> === PAUSE TestScriptTokenBadJSON70niks3-go-unit-tests> === RUN   TestScriptTokenScriptFails71niks3-go-unit-tests> === PAUSE TestScriptTokenScriptFails72niks3-go-unit-tests> === RUN   TestScriptTokenEmptyCommand73niks3-go-unit-tests> === PAUSE TestScriptTokenEmptyCommand74niks3-go-unit-tests> === CONT  TestDoServerRequestAttachesToken75niks3-go-unit-tests> === CONT  TestScriptTokenEmptyCommand76niks3-go-unit-tests> === CONT  TestGetStorePathHash77niks3-go-unit-tests> === CONT  TestSetClientTLSDoesNotMutateDefaultTransport78niks3-go-unit-tests> === CONT  TestScriptTokenEmptyToken79niks3-go-unit-tests> === CONT  TestScriptTokenCachesUntilRefresh80niks3-go-unit-tests> === CONT  TestScriptTokenBadJSON81niks3-go-unit-tests> === RUN   TestGetStorePathHash/valid_store_path82niks3-go-unit-tests> === CONT  TestScriptTokenScriptFails83niks3-go-unit-tests> --- PASS: TestScriptTokenEmptyCommand (0.00s)84niks3-go-unit-tests> === PAUSE TestGetStorePathHash/valid_store_path85niks3-go-unit-tests> === RUN   TestGetStorePathHash/basename_without_hyphen_should_error86niks3-go-unit-tests> === CONT  TestCaseHackSuffix87niks3-go-unit-tests> === CONT  TestConvertHashToNix3288niks3-go-unit-tests> === RUN   TestConvertHashToNix32/SRI_format_to_Nix3289niks3-go-unit-tests> === CONT  TestRateLimiterFeedback_400DoesNotCountAsSuccess90niks3-go-unit-tests> === CONT  TestRateLimiterFeedback91niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/429_enables_limiter92niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility93niks3-go-unit-tests> === CONT  TestParsePathInfoJSONMultiplePaths94niks3-go-unit-tests> === CONT  TestParsePathInfoJSON95niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility96niks3-go-unit-tests> === CONT  TestDumpPathSingleFile97niks3-go-unit-tests> === CONT  TestEncodeNixBase32WithRealHash98niks3-go-unit-tests> === CONT  TestEncodeNixBase3299niks3-go-unit-tests> === CONT  TestDumpPathWriterError100niks3-go-unit-tests> === CONT  TestResolveStorePath101niks3-go-unit-tests> === CONT  TestSetClientTLS102niks3-go-unit-tests> === CONT  TestShellSplitErrors103niks3-go-unit-tests> === PAUSE TestGetStorePathHash/basename_without_hyphen_should_error104niks3-go-unit-tests> --- PASS: TestShellSplitErrors (0.00s)105niks3-go-unit-tests> === CONT  TestStaticToken106niks3-go-unit-tests> === CONT  TestShellSplit107niks3-go-unit-tests> === CONT  TestSetClientTLSErrors108niks3-go-unit-tests> === CONT  TestDoWithRetry_BodyReplayedViaGetBody109niks3-go-unit-tests> === CONT  TestFileTokenEmpty110niks3-go-unit-tests> === CONT  TestScriptTokenNoExpiryRerunsEveryCall111niks3-go-unit-tests> === CONT  TestFileTokenMissing112niks3-go-unit-tests> === CONT  TestFileTokenReadsAndCaches113niks3-go-unit-tests> === CONT  TestUploadMultipart_SupersededByPeer114niks3-go-unit-tests> === CONT  TestDumpPathMatchesNix115niks3-go-unit-tests> === CONT  TestPartSizeForNAR116niks3-go-unit-tests> === RUN   TestGetStorePathHash/hash_with_invalid_characters_should_error117niks3-go-unit-tests> === RUN   TestPartSizeForNAR/zero_stays_at_minimum118niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/zero_stays_at_minimum119niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/SRI_format_to_Nix32120niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/429_enables_limiter121niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/503_enables_limiter122niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/503_enables_limiter123niks3-go-unit-tests> === RUN   TestConvertHashToNix32/already_Nix32_format124niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/already_Nix32_format125niks3-go-unit-tests> === RUN   TestConvertHashToNix32/invalid_format126niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/invalid_format127niks3-go-unit-tests> === CONT  TestConvertHashToNix32/SRI_format_to_Nix32128niks3-go-unit-tests> === CONT  TestConvertHashToNix32/invalid_format129niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/null_ca_field130niks3-go-unit-tests> --- PASS: TestEncodeNixBase32WithRealHash (0.00s)131niks3-go-unit-tests> === RUN   TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths132niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/null_ca_field133niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/old_string_format_-_text134niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths135niks3-go-unit-tests> === RUN   TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths136niks3-go-unit-tests> === CONT  TestConvertHashToNix32/already_Nix32_format137niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths138niks3-go-unit-tests> --- PASS: TestConvertHashToNix32 (0.00s)139niks3-go-unit-tests>     --- PASS: TestConvertHashToNix32/invalid_format (0.00s)140niks3-go-unit-tests>     --- PASS: TestConvertHashToNix32/SRI_format_to_Nix32 (0.00s)141niks3-go-unit-tests>     --- PASS: TestConvertHashToNix32/already_Nix32_format (0.00s)142niks3-go-unit-tests> === CONT  TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths143niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)144niks3-go-unit-tests> --- PASS: TestStaticToken (0.00s)145niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/Nix_format146niks3-go-unit-tests> --- PASS: TestShellSplit (0.00s)147niks3-go-unit-tests> --- PASS: TestResolveStorePath (0.00s)148niks3-go-unit-tests> === RUN   TestEncodeNixBase32/test_string_hash149niks3-go-unit-tests> === PAUSE TestEncodeNixBase32/test_string_hash150niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/200_does_not_enable_limiter151niks3-go-unit-tests> === CONT  TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths152niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Rate limiter enabled after throttle name=server-test rate=5153niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/200_does_not_enable_limiter154niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)155niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/old_string_format_with_colon156niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/old_string_format_with_colon157niks3-go-unit-tests> === RUN   TestEncodeNixBase32/empty_input158niks3-go-unit-tests> === PAUSE TestEncodeNixBase32/empty_input159niks3-go-unit-tests> === CONT  TestEncodeNixBase32/test_string_hash160niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/Nix_format161niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/400_does_not_enable_limiter162niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/Lix_format163niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/400_does_not_enable_limiter164niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/429_enables_limiter165niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/400_does_not_enable_limiter166niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/200_does_not_enable_limiter167niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/Lix_format168niks3-go-unit-tests> === CONT  TestEncodeNixBase32/empty_input169niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI170niks3-go-unit-tests> --- PASS: TestParsePathInfoJSONMultiplePaths (0.00s)171niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths (0.00s)172niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths (0.00s)173niks3-go-unit-tests> --- PASS: TestScriptTokenScriptFails (0.02s)174niks3-go-unit-tests> --- PASS: TestEncodeNixBase32 (0.00s)175niks3-go-unit-tests>     --- PASS: TestEncodeNixBase32/test_string_hash (0.00s)176niks3-go-unit-tests>     --- PASS: TestEncodeNixBase32/empty_input (0.00s)177niks3-go-unit-tests> --- PASS: TestScriptTokenBadJSON (0.01s)178niks3-go-unit-tests> --- PASS: TestScriptTokenEmptyToken (0.01s)179niks3-go-unit-tests> --- PASS: TestFileTokenReadsAndCaches (0.00s)180niks3-go-unit-tests> --- PASS: TestFileTokenMissing (0.00s)181niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/503_enables_limiter182niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/empty_input183niks3-go-unit-tests> --- PASS: TestFileTokenEmpty (0.00s)184niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/empty_input185niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/old_string_format_-_text186niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/old_string_format_-_fixed_recursive187niks3-go-unit-tests> === RUN   TestPartSizeForNAR/small_stays_at_minimum188niks3-go-unit-tests> === RUN   TestUploadMultipart_SupersededByPeer/exists189niks3-go-unit-tests> === PAUSE TestGetStorePathHash/hash_with_invalid_characters_should_error190niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI191niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/missing_cert_file192niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Rate limiter enabled after throttle name=server-test rate=5193niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/old_string_format_-_fixed_recursive194niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/new_structured_format_with_sha512195niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/new_structured_format_with_sha512196niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Request returned retryable status, retrying attempt=1 max_attempts=2 backoff=0s status=429 url=http://127.0.0.1:33355197niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Rate limiter enabled after throttle name=server-test rate=5198niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/new_structured_format_-_text199niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Request returned retryable status, retrying attempt=1 max_attempts=6 backoff=0s status=503 url=http://127.0.0.1:42593200niks3-go-unit-tests> === PAUSE TestUploadMultipart_SupersededByPeer/exists201niks3-go-unit-tests> === RUN   TestGetStorePathHash/hash_with_wrong_length_should_error202niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_cert_file203niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/whitespace_only204niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/missing_key_file205niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/whitespace_only206niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)207niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/invalid_JSON208niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/invalid_JSON209niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/Nix_format210niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/empty_input211niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Rate limiter enabled after throttle name=server-test rate=5212niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/whitespace_only213niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/new_structured_format_with_sha512214niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/old_string_format_with_colon215niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/new_structured_format_-_text216niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/new_structured_format_-_nar_method217niks3-go-unit-tests> --- PASS: TestDoServerRequestAttachesToken (0.02s)218niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Request returned retryable status, retrying attempt=1 max_attempts=2 backoff=0s status=503 url=http://127.0.0.1:41085219niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Rate limiter backed off name=server-test rate=5220niks3-go-unit-tests> === PAUSE TestGetStorePathHash/hash_with_wrong_length_should_error221niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Rate limiter backed off name=server-test rate=5222niks3-go-unit-tests> === RUN   TestUploadMultipart_SupersededByPeer/missing223niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Request returned retryable status, retrying attempt=2 max_attempts=6 backoff=0s status=503 url=http://127.0.0.1:42593224niks3-go-unit-tests> === CONT  TestGetStorePathHash/hash_with_wrong_length_should_error225niks3-go-unit-tests> === PAUSE TestUploadMultipart_SupersededByPeer/missing226niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/small_stays_at_minimum227niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_key_file228niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/invalid_JSON229niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/Lix_format230niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI231niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/new_structured_format_-_nar_method232niks3-go-unit-tests> === CONT  TestGetStorePathHash/basename_without_hyphen_should_error233niks3-go-unit-tests> === CONT  TestGetStorePathHash/valid_store_path234niks3-go-unit-tests> === CONT  TestUploadMultipart_SupersededByPeer/missing235niks3-go-unit-tests> === CONT  TestUploadMultipart_SupersededByPeer/exists236niks3-go-unit-tests> === CONT  TestGetStorePathHash/hash_with_invalid_characters_should_error237niks3-go-unit-tests> === RUN   TestPartSizeForNAR/80_GiB_fits_at_minimum238niks3-go-unit-tests> --- PASS: TestScriptTokenNoExpiryRerunsEveryCall (0.02s)239niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/null_ca_field240niks3-go-unit-tests> --- PASS: TestPathInfoHashCompatibility (0.02s)241niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI) (0.00s)242niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/old_string_format_with_colon (0.00s)243niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/new_structured_format_with_sha512 (0.00s)244niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI (0.00s)245niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/old_string_format_-_text246niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON (0.02s)247niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/whitespace_only (0.00s)248niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/Nix_format (0.00s)249niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/empty_input (0.00s)250niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/invalid_JSON (0.00s)251niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/Lix_format (0.00s)252niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/old_string_format_-_fixed_recursive253niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/new_structured_format_-_text254niks3-go-unit-tests> 2026/06/28 12:18:44 WARN Rate limiter backed off name=server-test rate=5255niks3-go-unit-tests> --- PASS: TestGetStorePathHash (0.02s)256niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/hash_with_wrong_length_should_error (0.00s)257niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/valid_store_path (0.00s)258niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/basename_without_hyphen_should_error (0.00s)259niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/hash_with_invalid_characters_should_error (0.00s)260niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/missing_ca_file261niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/new_structured_format_-_nar_method262niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_ca_file263niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/invalid_ca_file264niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/invalid_ca_file265niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/80_GiB_fits_at_minimum266niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility (0.03s)267niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/null_ca_field (0.00s)268niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/old_string_format_-_fixed_recursive (0.00s)269niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/old_string_format_-_text (0.00s)270niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/new_structured_format_-_nar_method (0.00s)271niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/new_structured_format_-_text (0.00s)272niks3-go-unit-tests> === RUN   TestPartSizeForNAR/115_GiB_needs_larger_parts273niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/missing_cert_file274niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/115_GiB_needs_larger_parts275niks3-go-unit-tests> === RUN   TestPartSizeForNAR/1_TiB276niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/missing_ca_file277niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/missing_key_file278niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/invalid_ca_file279niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/1_TiB280niks3-go-unit-tests> --- PASS: TestScriptTokenCachesUntilRefresh (0.03s)281niks3-go-unit-tests> --- PASS: TestDoWithRetry_BodyReplayedViaGetBody (0.03s)282niks3-go-unit-tests> === RUN   TestPartSizeForNAR/5_TiB_S3_max_object283niks3-go-unit-tests> --- PASS: TestSetClientTLSDoesNotMutateDefaultTransport (0.03s)284niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/5_TiB_S3_max_object285niks3-go-unit-tests> === RUN   TestPartSizeForNAR/capped_at_5_GiB286niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/capped_at_5_GiB287niks3-go-unit-tests> === CONT  TestPartSizeForNAR/zero_stays_at_minimum288niks3-go-unit-tests> === CONT  TestPartSizeForNAR/1_TiB289niks3-go-unit-tests> === CONT  TestPartSizeForNAR/capped_at_5_GiB290niks3-go-unit-tests> === CONT  TestPartSizeForNAR/115_GiB_needs_larger_parts291niks3-go-unit-tests> === CONT  TestPartSizeForNAR/80_GiB_fits_at_minimum292niks3-go-unit-tests> === CONT  TestPartSizeForNAR/5_TiB_S3_max_object293niks3-go-unit-tests> === CONT  TestPartSizeForNAR/small_stays_at_minimum294niks3-go-unit-tests> --- PASS: TestPartSizeForNAR (0.03s)295niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/zero_stays_at_minimum (0.00s)296niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/1_TiB (0.00s)297niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/capped_at_5_GiB (0.00s)298niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/115_GiB_needs_larger_parts (0.00s)299niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/80_GiB_fits_at_minimum (0.00s)300niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/5_TiB_S3_max_object (0.00s)301niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/small_stays_at_minimum (0.00s)302niks3-go-unit-tests> === RUN   TestSetClientTLS/rejects_connection_without_client_cert303niks3-go-unit-tests> === PAUSE TestSetClientTLS/rejects_connection_without_client_cert304niks3-go-unit-tests> === RUN   TestSetClientTLS/succeeds_with_client_cert_and_CA305niks3-go-unit-tests> === PAUSE TestSetClientTLS/succeeds_with_client_cert_and_CA306niks3-go-unit-tests> === RUN   TestSetClientTLS/preserves_debug_logging_transport307niks3-go-unit-tests> === PAUSE TestSetClientTLS/preserves_debug_logging_transport308niks3-go-unit-tests> --- PASS: TestSetClientTLSErrors (0.03s)309niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/missing_cert_file (0.00s)310niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/missing_key_file (0.00s)311niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/missing_ca_file (0.00s)312niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/invalid_ca_file (0.00s)313niks3-go-unit-tests> === CONT  TestSetClientTLS/rejects_connection_without_client_cert314niks3-go-unit-tests> === CONT  TestSetClientTLS/preserves_debug_logging_transport315niks3-go-unit-tests> === CONT  TestSetClientTLS/succeeds_with_client_cert_and_CA316niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback (0.00s)317niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/200_does_not_enable_limiter (0.02s)318niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/400_does_not_enable_limiter (0.02s)319niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/429_enables_limiter (0.02s)320niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/503_enables_limiter (0.02s)321niks3-go-unit-tests> 2026/06/28 12:18:44 http: TLS handshake error from 127.0.0.1:41820: remote error: tls: bad certificate322niks3-go-unit-tests> --- PASS: TestUploadMultipart_SupersededByPeer (0.02s)323niks3-go-unit-tests>     --- PASS: TestUploadMultipart_SupersededByPeer/exists (0.02s)324niks3-go-unit-tests>     --- PASS: TestUploadMultipart_SupersededByPeer/missing (0.02s)325niks3-go-unit-tests> --- PASS: TestDumpPathSingleFile (0.05s)326niks3-go-unit-tests> --- PASS: TestCaseHackSuffix (0.05s)327niks3-go-unit-tests> --- PASS: TestSetClientTLS (0.03s)328niks3-go-unit-tests>     --- PASS: TestSetClientTLS/rejects_connection_without_client_cert (0.02s)329niks3-go-unit-tests>     --- PASS: TestSetClientTLS/preserves_debug_logging_transport (0.02s)330niks3-go-unit-tests>     --- PASS: TestSetClientTLS/succeeds_with_client_cert_and_CA (0.02s)331niks3-go-unit-tests> --- PASS: TestDumpPathWriterError (0.09s)332niks3-go-unit-tests> --- PASS: TestDumpPathMatchesNix (0.13s)333niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback_400DoesNotCountAsSuccess (1.00s)334niks3-go-unit-tests> PASS335niks3-go-unit-tests> Running server tests...336niks3-go-unit-tests> The files belonging to this database system will be owned by user "nixbld".337niks3-go-unit-tests> This user must also own the server process.338niks3-go-unit-tests> 339niks3-go-unit-tests> The database cluster will be initialized with locale "C".340niks3-go-unit-tests> The default database encoding has accordingly been set to "SQL_ASCII".341niks3-go-unit-tests> The default text search configuration will be set to "english".342niks3-go-unit-tests> 343niks3-go-unit-tests> Data page checksums are disabled.344niks3-go-unit-tests> 345niks3-go-unit-tests> creating directory /build/postgres1863944082/data ... ok346niks3-go-unit-tests> creating subdirectories ... ok347niks3-go-unit-tests> selecting dynamic shared memory implementation ... posix348niks3-go-unit-tests> selecting default "max_connections" ... 100349niks3-go-unit-tests> selecting default "shared_buffers" ... 128MB350niks3-go-unit-tests> selecting default time zone ... UTC351niks3-go-unit-tests> creating configuration files ... ok352niks3-go-unit-tests> running bootstrap script ... ok353niks3-go-unit-tests> performing post-bootstrap initialization ... ok354niks3-go-unit-tests> syncing data to disk ... ok355niks3-go-unit-tests> 356niks3-go-unit-tests> initdb: warning: enabling "trust" authentication for local connections357niks3-go-unit-tests> initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.358niks3-go-unit-tests> 359niks3-go-unit-tests> Success. You can now start the database server using:360niks3-go-unit-tests> 361niks3-go-unit-tests>     pg_ctl -D /build/postgres1863944082/data -l logfile start362niks3-go-unit-tests> 363niks3-go-unit-tests> /build/postgres1863944082:5432 - no response364niks3-go-unit-tests> 2026-06-28 12:18:46.029 UTC [299] LOG:  starting PostgreSQL 17.10 on x86_64-pc-linux-gnu, compiled by clang version 21.1.8, 64-bit365niks3-go-unit-tests> 2026-06-28 12:18:46.030 UTC [299] LOG:  listening on Unix socket "/build/postgres1863944082/.s.PGSQL.5432"366niks3-go-unit-tests> 2026-06-28 12:18:46.033 UTC [303] LOG:  database system was shut down at 2026-06-28 12:18:45 UTC367niks3-go-unit-tests> 2026-06-28 12:18:46.037 UTC [299] LOG:  database system is ready to accept connections368niks3-go-unit-tests> /build/postgres1863944082:5432 - accepting connections369niks3-go-unit-tests> {"timestamp":"2026-06-28T12:18:46.388608495Z","level":"ERROR","fields":{"message":"list_path_raw: revjob err VolumeNotFound"},"target":"rustfs_ecstore::cache_value::metacache_set","filename":"crates/ecstore/src/cache_value/metacache_set.rs","line_number":486,"threadName":"rustfs-worker","threadId":"ThreadId(766)"}370niks3-go-unit-tests> 371niks3-go-unit-tests> thread 'rustfs-worker' (698) panicked at /build/rustfs-1.0.0-beta.7-vendor/source-registry-0/reqwest-0.13.4/src/async_impl/client.rs:2507:38:372niks3-go-unit-tests> Client::new(): reqwest::Error { kind: Builder, source: General("No CA certificates were loaded from the system") }373niks3-go-unit-tests> note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace374niks3-go-unit-tests> === RUN   TestService_AuthMiddleware375niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware376niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_MTLSProxyHeader377niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_MTLSProxyHeader378niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_MTLSBoundSubjects379niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_MTLSBoundSubjects380niks3-go-unit-tests> === RUN   TestService_ReadAuthMiddleware381niks3-go-unit-tests> === PAUSE TestService_ReadAuthMiddleware382niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC383niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC384niks3-go-unit-tests> === RUN   TestCacheConfigHandler385niks3-go-unit-tests> === PAUSE TestCacheConfigHandler386niks3-go-unit-tests> === RUN   TestClientCADerivations387niks3-go-unit-tests> === PAUSE TestClientCADerivations388niks3-go-unit-tests> === RUN   TestClientErrorHandling389niks3-go-unit-tests> === PAUSE TestClientErrorHandling390niks3-go-unit-tests> === RUN   TestClientIntegration391niks3-go-unit-tests> === PAUSE TestClientIntegration392niks3-go-unit-tests> === RUN   TestClientMultipleUploads393niks3-go-unit-tests> === PAUSE TestClientMultipleUploads394niks3-go-unit-tests> === RUN   TestClientWithDependencies395niks3-go-unit-tests> === PAUSE TestClientWithDependencies396niks3-go-unit-tests> === RUN   TestPinProtectsFromGC397niks3-go-unit-tests> === PAUSE TestPinProtectsFromGC398niks3-go-unit-tests> === RUN   TestGCBugBareHashReferences399niks3-go-unit-tests> === PAUSE TestGCBugBareHashReferences400niks3-go-unit-tests> === RUN   TestGCMetrics401niks3-go-unit-tests> === PAUSE TestGCMetrics402niks3-go-unit-tests> === RUN   TestGCTaskStore_StartNew403niks3-go-unit-tests> === PAUSE TestGCTaskStore_StartNew404niks3-go-unit-tests> === RUN   TestGCTaskStore_DeduplicateSameParams405niks3-go-unit-tests> === PAUSE TestGCTaskStore_DeduplicateSameParams406niks3-go-unit-tests> === RUN   TestGCTaskStore_ConflictDifferentParams407niks3-go-unit-tests> === PAUSE TestGCTaskStore_ConflictDifferentParams408niks3-go-unit-tests> === RUN   TestGCTaskStore_GetEmpty409niks3-go-unit-tests> === PAUSE TestGCTaskStore_GetEmpty410niks3-go-unit-tests> === RUN   TestGCTaskStore_GetReturnsLatest411niks3-go-unit-tests> === PAUSE TestGCTaskStore_GetReturnsLatest412niks3-go-unit-tests> === RUN   TestGCTaskStore_CompletedAllowsNewTask413niks3-go-unit-tests> === PAUSE TestGCTaskStore_CompletedAllowsNewTask414niks3-go-unit-tests> === RUN   TestGCTaskStore_PhaseUpdates415niks3-go-unit-tests> === PAUSE TestGCTaskStore_PhaseUpdates416niks3-go-unit-tests> === RUN   TestGCTaskStore_Fail417niks3-go-unit-tests> === PAUSE TestGCTaskStore_Fail418niks3-go-unit-tests> === RUN   TestService_healthCheckHandler419niks3-go-unit-tests> === PAUSE TestService_healthCheckHandler420niks3-go-unit-tests> === RUN   TestGenerateLandingPage421niks3-go-unit-tests> === PAUSE TestGenerateLandingPage422niks3-go-unit-tests> === RUN   TestNARDeduplicationMetadataUploadBug423niks3-go-unit-tests> === PAUSE TestNARDeduplicationMetadataUploadBug424niks3-go-unit-tests> === RUN   TestMetricsInventory425niks3-go-unit-tests> === PAUSE TestMetricsInventory426niks3-go-unit-tests> === RUN   TestService_NativeMTLS427niks3-go-unit-tests> === PAUSE TestService_NativeMTLS428niks3-go-unit-tests> === RUN   TestServerTLSConfig429niks3-go-unit-tests> === PAUSE TestServerTLSConfig430niks3-go-unit-tests> === RUN   TestMultipartCleanup431niks3-go-unit-tests> === PAUSE TestMultipartCleanup432niks3-go-unit-tests> === RUN   TestObjectStatsTrigger433niks3-go-unit-tests> === PAUSE TestObjectStatsTrigger434niks3-go-unit-tests> === RUN   TestOrphanedObjectsGC435niks3-go-unit-tests> === PAUSE TestOrphanedObjectsGC436niks3-go-unit-tests> === RUN   TestOrphanedObjectsGCStressTest437niks3-go-unit-tests> === PAUSE TestOrphanedObjectsGCStressTest438niks3-go-unit-tests> === RUN   TestResurrectedObjectNotDeleted439niks3-go-unit-tests> === PAUSE TestResurrectedObjectNotDeleted440niks3-go-unit-tests> === RUN   TestParseSingleRange441niks3-go-unit-tests> === PAUSE TestParseSingleRange442niks3-go-unit-tests> === RUN   TestIsValidCachePath443niks3-go-unit-tests> === PAUSE TestIsValidCachePath444niks3-go-unit-tests> === RUN   TestReadProxyNarinfo445niks3-go-unit-tests> === PAUSE TestReadProxyNarinfo446niks3-go-unit-tests> === RUN   TestReadProxyNarinfoAlreadyDecompressed447niks3-go-unit-tests> === PAUSE TestReadProxyNarinfoAlreadyDecompressed448niks3-go-unit-tests> === RUN   TestReadProxyNarStreaming449niks3-go-unit-tests> === PAUSE TestReadProxyNarStreaming450niks3-go-unit-tests> === RUN   TestReadProxy404451niks3-go-unit-tests> === PAUSE TestReadProxy404452niks3-go-unit-tests> === RUN   TestReadProxyInvalidPath453niks3-go-unit-tests> === PAUSE TestReadProxyInvalidPath454niks3-go-unit-tests> === RUN   TestReadProxyHead455niks3-go-unit-tests> === PAUSE TestReadProxyHead456niks3-go-unit-tests> === RUN   TestReadProxyConditionalGet457niks3-go-unit-tests> === PAUSE TestReadProxyConditionalGet458niks3-go-unit-tests> === RUN   TestReadProxyRootRedirectsToIndexHTML459niks3-go-unit-tests> === PAUSE TestReadProxyRootRedirectsToIndexHTML460niks3-go-unit-tests> === RUN   TestReadProxyDisabled461niks3-go-unit-tests> === PAUSE TestReadProxyDisabled462niks3-go-unit-tests> === RUN   TestReadProxyRangeRequest463niks3-go-unit-tests> === PAUSE TestReadProxyRangeRequest464niks3-go-unit-tests> === RUN   TestRedundantMultipartUpload465niks3-go-unit-tests> === PAUSE TestRedundantMultipartUpload466niks3-go-unit-tests> === RUN   TestCompleteMultipartUpload_ErrorButObjectExists467niks3-go-unit-tests> === PAUSE TestCompleteMultipartUpload_ErrorButObjectExists468niks3-go-unit-tests> === RUN   TestService_Rustfstest469niks3-go-unit-tests> === PAUSE TestService_Rustfstest470niks3-go-unit-tests> === RUN   TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle471niks3-go-unit-tests> === PAUSE TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle472niks3-go-unit-tests> === RUN   TestProxyWriteTimeout473niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout474niks3-go-unit-tests> === RUN   TestIsValidUploadKey475niks3-go-unit-tests> === PAUSE TestIsValidUploadKey476niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys477niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys478niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody479niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody480niks3-go-unit-tests> === RUN   TestService_cleanupPendingClosuresHandler481niks3-go-unit-tests> === PAUSE TestService_cleanupPendingClosuresHandler482niks3-go-unit-tests> === RUN   TestService_createPendingClosureHandler483niks3-go-unit-tests> === PAUSE TestService_createPendingClosureHandler484niks3-go-unit-tests> === RUN   TestService_verifyS3Integrity485niks3-go-unit-tests> === PAUSE TestService_verifyS3Integrity486niks3-go-unit-tests> === RUN   TestCompleteMultipartUnregistered487niks3-go-unit-tests> === PAUSE TestCompleteMultipartUnregistered488niks3-go-unit-tests> === RUN   TestCreatePendingClosure_SmallNARUsesSimplePUT489niks3-go-unit-tests> === PAUSE TestCreatePendingClosure_SmallNARUsesSimplePUT490niks3-go-unit-tests> === CONT  TestService_AuthMiddleware491niks3-go-unit-tests> === CONT  TestObjectStatsTrigger492niks3-go-unit-tests> === CONT  TestReadProxyRangeRequest493niks3-go-unit-tests> === CONT  TestReadProxyNarStreaming494niks3-go-unit-tests> === CONT  TestGCTaskStore_DeduplicateSameParams495niks3-go-unit-tests> === CONT  TestService_createPendingClosureHandler496niks3-go-unit-tests> === CONT  TestClientIntegration497niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_MTLSBoundSubjects498niks3-go-unit-tests> === CONT  TestMetricsInventory499niks3-go-unit-tests> --- PASS: TestGCTaskStore_DeduplicateSameParams (0.00s)500niks3-go-unit-tests> === CONT  TestClientWithDependencies501niks3-go-unit-tests> === CONT  TestPinProtectsFromGC502niks3-go-unit-tests> === CONT  TestClientMultipleUploads503niks3-go-unit-tests> === CONT  TestOrphanedObjectsGCStressTest504niks3-go-unit-tests> === CONT  TestUploadHandlersRejectInvalidKeys505niks3-go-unit-tests> === CONT  TestResurrectedObjectNotDeleted506niks3-go-unit-tests> === CONT  TestMultipartCleanup507niks3-go-unit-tests> === CONT  TestCreatePendingClosure_SmallNARUsesSimplePUT508niks3-go-unit-tests> === CONT  TestServerTLSConfig509niks3-go-unit-tests> === CONT  TestCompleteMultipartUnregistered510niks3-go-unit-tests> === CONT  TestService_NativeMTLS511niks3-go-unit-tests> === CONT  TestService_verifyS3Integrity512niks3-go-unit-tests> === CONT  TestNARDeduplicationMetadataUploadBug513niks3-go-unit-tests> === CONT  TestGenerateLandingPage514niks3-go-unit-tests> === CONT  TestReadProxyConditionalGet515niks3-go-unit-tests> === CONT  TestReadProxyDisabled516niks3-go-unit-tests> === CONT  TestReadProxyRootRedirectsToIndexHTML517niks3-go-unit-tests> === CONT  TestReadProxyHead518niks3-go-unit-tests> === CONT  TestGCBugBareHashReferences519niks3-go-unit-tests> === CONT  TestGCTaskStore_StartNew520niks3-go-unit-tests> === CONT  TestGCMetrics521niks3-go-unit-tests> === CONT  TestOrphanedObjectsGC522niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_OIDC523niks3-go-unit-tests> === CONT  TestClientErrorHandling524niks3-go-unit-tests> === CONT  TestReadProxy404525niks3-go-unit-tests> === CONT  TestClientCADerivations526niks3-go-unit-tests> === CONT  TestParseSingleRange527niks3-go-unit-tests> --- PASS: TestGCTaskStore_StartNew (0.00s)528niks3-go-unit-tests> === CONT  TestReadProxyNarinfo529niks3-go-unit-tests> === RUN   TestClientErrorHandling/InvalidStorePath530niks3-go-unit-tests> === CONT  TestCacheConfigHandler531niks3-go-unit-tests> === CONT  TestIsValidCachePath532niks3-go-unit-tests> === CONT  TestReadProxyNarinfoAlreadyDecompressed533niks3-go-unit-tests> === CONT  TestService_cleanupPendingClosuresHandler534niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_MTLSProxyHeader535niks3-go-unit-tests> === CONT  TestCompleteMultipartUpload_ErrorButObjectExists536niks3-go-unit-tests> === CONT  TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle537niks3-go-unit-tests> === CONT  TestGCTaskStore_CompletedAllowsNewTask538niks3-go-unit-tests> --- PASS: TestGCTaskStore_CompletedAllowsNewTask (0.00s)539niks3-go-unit-tests> === CONT  TestIsValidUploadKey540niks3-go-unit-tests> === RUN   TestIsValidUploadKey/narinfo541niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/narinfo542niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_zst543niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_zst544niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_xz545niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_xz546niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_plain547niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_plain548niks3-go-unit-tests> === CONT  TestGCTaskStore_Fail549niks3-go-unit-tests> --- PASS: TestGCTaskStore_Fail (0.00s)550niks3-go-unit-tests> === CONT  TestService_Rustfstest551niks3-go-unit-tests> === CONT  TestGCTaskStore_GetEmpty552niks3-go-unit-tests> --- PASS: TestGCTaskStore_GetEmpty (0.00s)553niks3-go-unit-tests> === CONT  TestProxyWriteTimeout554niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/narinfo555niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/narinfo556niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/1_GiB_nar557niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/1_GiB_nar558niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/10_GiB_nar559niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/10_GiB_nar560niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/unknown_size561niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/unknown_size562niks3-go-unit-tests> === CONT  TestGCTaskStore_PhaseUpdates563niks3-go-unit-tests> --- PASS: TestGCTaskStore_PhaseUpdates (0.00s)564niks3-go-unit-tests> === CONT  TestGCTaskStore_GetReturnsLatest565niks3-go-unit-tests> --- PASS: TestGCTaskStore_GetReturnsLatest (0.00s)566niks3-go-unit-tests> === CONT  TestRedundantMultipartUpload567niks3-go-unit-tests> === CONT  TestUploadHandlersRejectOversizedBody568niks3-go-unit-tests> === CONT  TestService_ReadAuthMiddleware569niks3-go-unit-tests> === CONT  TestGCTaskStore_ConflictDifferentParams570niks3-go-unit-tests> === CONT  TestReadProxyInvalidPath571niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info572niks3-go-unit-tests> === CONT  TestService_healthCheckHandler573niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info574niks3-go-unit-tests> === RUN   TestServerTLSConfig/no_client_CA575niks3-go-unit-tests> === RUN   TestParseSingleRange/none576niks3-go-unit-tests> === PAUSE TestParseSingleRange/none577niks3-go-unit-tests> === RUN   TestCacheConfigHandler/full_config,_no_issuer578niks3-go-unit-tests> === RUN   TestIsValidCachePath/narinfo579niks3-go-unit-tests> === PAUSE TestClientErrorHandling/InvalidStorePath580niks3-go-unit-tests> === RUN   TestIsValidUploadKey/listing581niks3-go-unit-tests> === CONT  TestProxyWriteTimeout/narinfo582niks3-go-unit-tests> === CONT  TestProxyWriteTimeout/unknown_size583niks3-go-unit-tests> === CONT  TestProxyWriteTimeout/10_GiB_nar584niks3-go-unit-tests> === CONT  TestProxyWriteTimeout/1_GiB_nar585niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/listing586niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal587niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log588niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal589niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log590niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/full_config,_no_issuer591niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_home-manager_file592niks3-go-unit-tests> === RUN   TestParseSingleRange/unknown_unit593niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_home-manager_file594niks3-go-unit-tests> === PAUSE TestIsValidCachePath/narinfo595niks3-go-unit-tests> === RUN   TestClientErrorHandling/InvalidAuthToken596niks3-go-unit-tests> === RUN   TestIsValidCachePath/narinfo_all_nix_base32_chars597niks3-go-unit-tests> --- PASS: TestGenerateLandingPage (0.01s)598niks3-go-unit-tests> === PAUSE TestIsValidCachePath/narinfo_all_nix_base32_chars599niks3-go-unit-tests> --- PASS: TestGCTaskStore_ConflictDifferentParams (0.00s)600niks3-go-unit-tests> === PAUSE TestServerTLSConfig/no_client_CA601niks3-go-unit-tests> --- PASS: TestProxyWriteTimeout (0.00s)602niks3-go-unit-tests>     --- PASS: TestProxyWriteTimeout/narinfo (0.00s)603niks3-go-unit-tests>     --- PASS: TestProxyWriteTimeout/unknown_size (0.00s)604niks3-go-unit-tests>     --- PASS: TestProxyWriteTimeout/10_GiB_nar (0.00s)605niks3-go-unit-tests>     --- PASS: TestProxyWriteTimeout/1_GiB_nar (0.00s)606niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key607niks3-go-unit-tests> === RUN   TestServerTLSConfig/missing_CA_file608niks3-go-unit-tests> === PAUSE TestServerTLSConfig/missing_CA_file609niks3-go-unit-tests> === PAUSE TestParseSingleRange/unknown_unit610niks3-go-unit-tests> === RUN   TestCacheConfigHandler/no_cache_url_configured611niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/no_cache_url_configured612niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_plus_in_name613niks3-go-unit-tests> === RUN   TestIsValidCachePath/nar_zst614niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_plus_in_name615niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_zst616niks3-go-unit-tests> === PAUSE TestClientErrorHandling/InvalidAuthToken617niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_question_mark618niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key619niks3-go-unit-tests> === RUN   TestCacheConfigHandler/no_signing_keys620niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_question_mark621niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key622niks3-go-unit-tests> === RUN   TestIsValidCachePath/nar_xz623niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_equals624niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_equals625niks3-go-unit-tests> === RUN   TestIsValidUploadKey/realisation626niks3-go-unit-tests> === RUN   TestParseSingleRange/multi-range_ignored627niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/realisation628niks3-go-unit-tests> === PAUSE TestParseSingleRange/multi-range_ignored629niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key630niks3-go-unit-tests> === RUN   TestIsValidUploadKey/realisation_plus_in_output631niks3-go-unit-tests> === CONT  TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal632niks3-go-unit-tests> === CONT  TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key633niks3-go-unit-tests> === RUN   TestServerTLSConfig/not_a_PEM_file634niks3-go-unit-tests> === PAUSE TestServerTLSConfig/not_a_PEM_file635niks3-go-unit-tests> === CONT  TestServerTLSConfig/no_client_CA636niks3-go-unit-tests> === CONT  TestServerTLSConfig/not_a_PEM_file637niks3-go-unit-tests> === CONT  TestServerTLSConfig/missing_CA_file638niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/no_signing_keys639niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_xz640niks3-go-unit-tests> === RUN   TestClientErrorHandling/ServerNotAvailable641niks3-go-unit-tests> === RUN   TestParseSingleRange/malformed_no_dash642niks3-go-unit-tests> === PAUSE TestClientErrorHandling/ServerNotAvailable643niks3-go-unit-tests> === RUN   TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator644niks3-go-unit-tests> === PAUSE TestParseSingleRange/malformed_no_dash645niks3-go-unit-tests> === CONT  TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key646niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator647niks3-go-unit-tests> === RUN   TestParseSingleRange/malformed_both_empty648niks3-go-unit-tests> === CONT  TestCacheConfigHandler/full_config,_no_issuer649niks3-go-unit-tests> === CONT  TestCacheConfigHandler/no_signing_keys650niks3-go-unit-tests> === CONT  TestCacheConfigHandler/no_cache_url_configured651niks3-go-unit-tests> === CONT  TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator652niks3-go-unit-tests> === CONT  TestClientErrorHandling/InvalidStorePath653niks3-go-unit-tests> === PAUSE TestParseSingleRange/malformed_both_empty654niks3-go-unit-tests> === CONT  TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info655niks3-go-unit-tests> === RUN   TestParseSingleRange/malformed_end_before_start656niks3-go-unit-tests> === PAUSE TestParseSingleRange/malformed_end_before_start657niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/realisation_plus_in_output658niks3-go-unit-tests> === CONT  TestClientErrorHandling/ServerNotAvailable659niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nix-cache-info660niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nix-cache-info661niks3-go-unit-tests> === RUN   TestIsValidUploadKey/index.html662niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/index.html663niks3-go-unit-tests> === RUN   TestIsValidUploadKey/narinfo_key,_nar_type664niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/narinfo_key,_nar_type665niks3-go-unit-tests> === RUN   TestIsValidCachePath/nar_bz2666niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_key,_narinfo_type667niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_key,_narinfo_type668niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_bz2669niks3-go-unit-tests> === RUN   TestIsValidCachePath/nar_uncompressed670niks3-go-unit-tests> --- PASS: TestCacheConfigHandler (0.01s)671niks3-go-unit-tests>     --- PASS: TestCacheConfigHandler/no_signing_keys (0.00s)672niks3-go-unit-tests>     --- PASS: TestCacheConfigHandler/full_config,_no_issuer (0.00s)673niks3-go-unit-tests>     --- PASS: TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator (0.00s)674niks3-go-unit-tests>     --- PASS: TestCacheConfigHandler/no_cache_url_configured (0.00s)675niks3-go-unit-tests> === RUN   TestParseSingleRange/closed676niks3-go-unit-tests> === PAUSE TestParseSingleRange/closed677niks3-go-unit-tests> 2026/06/28 12:18:46 INFO Received request for more parts method=POST path=/678niks3-go-unit-tests> === CONT  TestClientErrorHandling/InvalidAuthToken679niks3-go-unit-tests> 2026/06/28 12:18:46 INFO Received uploads request method=POST path=/680niks3-go-unit-tests> --- PASS: TestServerTLSConfig (0.01s)681niks3-go-unit-tests>     --- PASS: TestServerTLSConfig/no_client_CA (0.00s)682niks3-go-unit-tests>     --- PASS: TestServerTLSConfig/missing_CA_file (0.00s)683niks3-go-unit-tests>     --- PASS: TestServerTLSConfig/not_a_PEM_file (0.00s)684niks3-go-unit-tests> 2026/06/28 12:18:46 INFO Received uploads request method=POST path=/685niks3-go-unit-tests> === RUN   TestIsValidUploadKey/listing_key,_narinfo_type686niks3-go-unit-tests> 2026/06/28 12:18:46 INFO Received complete multipart upload request method=POST path=/687niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/listing_key,_narinfo_type688niks3-go-unit-tests> === RUN   TestParseSingleRange/open-ended689niks3-go-unit-tests> === PAUSE TestParseSingleRange/open-ended690niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_uncompressed691niks3-go-unit-tests> === RUN   TestParseSingleRange/end_clamped_to_size692niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectInvalidKeys (0.01s)693niks3-go-unit-tests>     --- PASS: TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key (0.00s)694niks3-go-unit-tests>     --- PASS: TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal (0.00s)695niks3-go-unit-tests>     --- PASS: TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info (0.00s)696niks3-go-unit-tests>     --- PASS: TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key (0.00s)697niks3-go-unit-tests> === RUN   TestIsValidCachePath/ls698niks3-go-unit-tests> === PAUSE TestParseSingleRange/end_clamped_to_size699niks3-go-unit-tests> === PAUSE TestIsValidCachePath/ls700niks3-go-unit-tests> === RUN   TestIsValidCachePath/log701niks3-go-unit-tests> === RUN   TestIsValidUploadKey/traversal702niks3-go-unit-tests> === PAUSE TestIsValidCachePath/log703niks3-go-unit-tests> === RUN   TestIsValidCachePath/realisation704niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/traversal705niks3-go-unit-tests> === PAUSE TestIsValidCachePath/realisation706niks3-go-unit-tests> === RUN   TestIsValidUploadKey/traversal_nar707niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/traversal_nar708niks3-go-unit-tests> === RUN   TestParseSingleRange/suffix709niks3-go-unit-tests> === RUN   TestIsValidCachePath/nix-cache-info710niks3-go-unit-tests> === PAUSE TestParseSingleRange/suffix711niks3-go-unit-tests> === RUN   TestIsValidUploadKey/absolute712niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/absolute713niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nix-cache-info714niks3-go-unit-tests> === RUN   TestIsValidUploadKey/empty_key715niks3-go-unit-tests> === RUN   TestIsValidCachePath/index.html716niks3-go-unit-tests> === PAUSE TestIsValidCachePath/index.html717niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/empty_key718niks3-go-unit-tests> === RUN   TestParseSingleRange/suffix_exceeds_size719niks3-go-unit-tests> === RUN   TestIsValidUploadKey/unknown_type720niks3-go-unit-tests> === RUN   TestIsValidCachePath/traversal_parent721niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/unknown_type722niks3-go-unit-tests> === PAUSE TestIsValidCachePath/traversal_parent723niks3-go-unit-tests> === CONT  TestIsValidUploadKey/narinfo724niks3-go-unit-tests> === RUN   TestIsValidCachePath/traversal_in_middle725niks3-go-unit-tests> === CONT  TestIsValidUploadKey/empty_key726niks3-go-unit-tests> === CONT  TestIsValidUploadKey/build_log_equals727niks3-go-unit-tests> === CONT  TestIsValidUploadKey/nar_plain728niks3-go-unit-tests> === CONT  TestIsValidUploadKey/traversal729niks3-go-unit-tests> === CONT  TestIsValidUploadKey/nar_key,_narinfo_type730niks3-go-unit-tests> === CONT  TestIsValidUploadKey/build_log_question_mark731niks3-go-unit-tests> === CONT  TestIsValidUploadKey/listing732niks3-go-unit-tests> === CONT  TestIsValidUploadKey/build_log_plus_in_name733niks3-go-unit-tests> === CONT  TestIsValidUploadKey/nix-cache-info734niks3-go-unit-tests> === CONT  TestIsValidUploadKey/realisation_plus_in_output735niks3-go-unit-tests> === PAUSE TestIsValidCachePath/traversal_in_middle736niks3-go-unit-tests> === CONT  TestIsValidUploadKey/unknown_type737niks3-go-unit-tests> === RUN   TestIsValidCachePath/invalid_char_e738niks3-go-unit-tests> === PAUSE TestParseSingleRange/suffix_exceeds_size739niks3-go-unit-tests> === CONT  TestIsValidUploadKey/build_log_home-manager_file740niks3-go-unit-tests> === RUN   TestParseSingleRange/single_byte741niks3-go-unit-tests> === CONT  TestIsValidUploadKey/realisation742niks3-go-unit-tests> === PAUSE TestParseSingleRange/single_byte743niks3-go-unit-tests> === CONT  TestIsValidUploadKey/absolute744niks3-go-unit-tests> === RUN   TestParseSingleRange/start_past_EOF745niks3-go-unit-tests> === CONT  TestIsValidUploadKey/traversal_nar746niks3-go-unit-tests> === PAUSE TestParseSingleRange/start_past_EOF747niks3-go-unit-tests> === CONT  TestIsValidUploadKey/build_log748niks3-go-unit-tests> === RUN   TestParseSingleRange/start_far_past_EOF749niks3-go-unit-tests> === PAUSE TestParseSingleRange/start_far_past_EOF750niks3-go-unit-tests> === CONT  TestParseSingleRange/none751niks3-go-unit-tests> === CONT  TestParseSingleRange/end_clamped_to_size752niks3-go-unit-tests> === CONT  TestParseSingleRange/malformed_both_empty753niks3-go-unit-tests> === CONT  TestParseSingleRange/start_past_EOF754niks3-go-unit-tests> === CONT  TestParseSingleRange/single_byte755niks3-go-unit-tests> === CONT  TestParseSingleRange/unknown_unit756niks3-go-unit-tests> === CONT  TestParseSingleRange/malformed_end_before_start757niks3-go-unit-tests> === CONT  TestParseSingleRange/start_far_past_EOF758niks3-go-unit-tests> 2026/06/28 12:18:46 INFO OIDC provider initialized name=test759niks3-go-unit-tests> === CONT  TestParseSingleRange/suffix_exceeds_size760niks3-go-unit-tests> === CONT  TestIsValidUploadKey/narinfo_key,_nar_type761niks3-go-unit-tests> === CONT  TestIsValidUploadKey/nar_zst762niks3-go-unit-tests> === CONT  TestIsValidUploadKey/listing_key,_narinfo_type763niks3-go-unit-tests> === CONT  TestIsValidUploadKey/index.html764niks3-go-unit-tests> === PAUSE TestIsValidCachePath/invalid_char_e765niks3-go-unit-tests> === RUN   TestIsValidCachePath/invalid_char_u766niks3-go-unit-tests> === PAUSE TestIsValidCachePath/invalid_char_u767niks3-go-unit-tests> === RUN   TestIsValidCachePath/random_path768niks3-go-unit-tests> === PAUSE TestIsValidCachePath/random_path769niks3-go-unit-tests> === RUN   TestIsValidCachePath/empty770niks3-go-unit-tests> === CONT  TestParseSingleRange/malformed_no_dash771niks3-go-unit-tests> === PAUSE TestIsValidCachePath/empty772niks3-go-unit-tests> === CONT  TestParseSingleRange/open-ended773niks3-go-unit-tests> === RUN   TestIsValidCachePath/leading_slash774niks3-go-unit-tests> === CONT  TestIsValidUploadKey/nar_xz775niks3-go-unit-tests> === PAUSE TestIsValidCachePath/leading_slash776niks3-go-unit-tests> === RUN   TestIsValidCachePath/wrong_extension777niks3-go-unit-tests> === PAUSE TestIsValidCachePath/wrong_extension778niks3-go-unit-tests> --- PASS: TestIsValidUploadKey (0.01s)779niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/empty_key (0.00s)780niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/traversal (0.00s)781niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/narinfo (0.00s)782niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/build_log_equals (0.00s)783niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/listing (0.00s)784niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/nar_key,_narinfo_type (0.00s)785niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/nar_plain (0.00s)786niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/build_log_question_mark (0.00s)787niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/build_log_plus_in_name (0.00s)788niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/nix-cache-info (0.00s)789niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/realisation_plus_in_output (0.00s)790niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/unknown_type (0.00s)791niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/build_log_home-manager_file (0.00s)792niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/realisation (0.00s)793niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/absolute (0.00s)794niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/traversal_nar (0.00s)795niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/build_log (0.00s)796niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/narinfo_key,_nar_type (0.00s)797niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/nar_zst (0.00s)798niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/listing_key,_narinfo_type (0.00s)799niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/index.html (0.00s)800niks3-go-unit-tests>     --- PASS: TestIsValidUploadKey/nar_xz (0.00s)801niks3-go-unit-tests> === RUN   TestIsValidCachePath/short_hash802niks3-go-unit-tests> === PAUSE TestIsValidCachePath/short_hash803niks3-go-unit-tests> === CONT  TestIsValidCachePath/narinfo804niks3-go-unit-tests> === CONT  TestParseSingleRange/suffix805niks3-go-unit-tests> === CONT  TestIsValidCachePath/index.html806niks3-go-unit-tests> === CONT  TestIsValidCachePath/traversal_parent807niks3-go-unit-tests> === CONT  TestIsValidCachePath/nar_uncompressed808niks3-go-unit-tests> === CONT  TestParseSingleRange/multi-range_ignored809niks3-go-unit-tests> === CONT  TestIsValidCachePath/ls810niks3-go-unit-tests> === CONT  TestIsValidCachePath/nar_bz2811niks3-go-unit-tests> === CONT  TestIsValidCachePath/nar_xz812niks3-go-unit-tests> === CONT  TestIsValidCachePath/nar_zst813niks3-go-unit-tests> === CONT  TestIsValidCachePath/empty814niks3-go-unit-tests> === CONT  TestIsValidCachePath/narinfo_all_nix_base32_chars815niks3-go-unit-tests> === CONT  TestIsValidCachePath/short_hash816niks3-go-unit-tests> === CONT  TestIsValidCachePath/wrong_extension817niks3-go-unit-tests> === CONT  TestIsValidCachePath/realisation818niks3-go-unit-tests> === CONT  TestIsValidCachePath/leading_slash819niks3-go-unit-tests> === CONT  TestParseSingleRange/closed820niks3-go-unit-tests> --- PASS: TestParseSingleRange (0.01s)821niks3-go-unit-tests>     --- PASS: TestParseSingleRange/none (0.00s)822niks3-go-unit-tests>     --- PASS: TestParseSingleRange/end_clamped_to_size (0.00s)823niks3-go-unit-tests>     --- PASS: TestParseSingleRange/unknown_unit (0.00s)824niks3-go-unit-tests>     --- PASS: TestParseSingleRange/single_byte (0.00s)825niks3-go-unit-tests>     --- PASS: TestParseSingleRange/malformed_end_before_start (0.00s)826niks3-go-unit-tests>     --- PASS: TestParseSingleRange/start_past_EOF (0.00s)827niks3-go-unit-tests>     --- PASS: TestParseSingleRange/malformed_both_empty (0.00s)828niks3-go-unit-tests>     --- PASS: TestParseSingleRange/start_far_past_EOF (0.00s)829niks3-go-unit-tests>     --- PASS: TestParseSingleRange/suffix_exceeds_size (0.00s)830niks3-go-unit-tests>     --- PASS: TestParseSingleRange/malformed_no_dash (0.00s)831niks3-go-unit-tests>     --- PASS: TestParseSingleRange/open-ended (0.00s)832niks3-go-unit-tests>     --- PASS: TestParseSingleRange/suffix (0.00s)833niks3-go-unit-tests>     --- PASS: TestParseSingleRange/multi-range_ignored (0.00s)834niks3-go-unit-tests>     --- PASS: TestParseSingleRange/closed (0.00s)835niks3-go-unit-tests> === CONT  TestIsValidCachePath/random_path836niks3-go-unit-tests> === CONT  TestIsValidCachePath/log837niks3-go-unit-tests> === CONT  TestIsValidCachePath/invalid_char_e838niks3-go-unit-tests> === CONT  TestIsValidCachePath/traversal_in_middle839niks3-go-unit-tests> === CONT  TestIsValidCachePath/nix-cache-info840niks3-go-unit-tests> === CONT  TestIsValidCachePath/invalid_char_u841niks3-go-unit-tests> --- PASS: TestIsValidCachePath (0.01s)842niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/narinfo (0.00s)843niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/index.html (0.00s)844niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/traversal_parent (0.00s)845niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/nar_uncompressed (0.00s)846niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/ls (0.00s)847niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/nar_bz2 (0.00s)848niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/nar_xz (0.00s)849niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/nar_zst (0.00s)850niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/empty (0.00s)851niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/narinfo_all_nix_base32_chars (0.00s)852niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/short_hash (0.00s)853niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/wrong_extension (0.00s)854niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/realisation (0.00s)855niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/leading_slash (0.00s)856niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/random_path (0.00s)857niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/log (0.00s)858niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/invalid_char_e (0.00s)859niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/traversal_in_middle (0.00s)860niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/nix-cache-info (0.00s)861niks3-go-unit-tests>     --- PASS: TestIsValidCachePath/invalid_char_u (0.00s)862niks3-go-unit-tests> 2026/06/28 12:18:46 WARN Request failed, retrying attempt=1 max_attempts=6 backoff=100ms error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures863niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody/create_pending_closure864niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/create_pending_closure865niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody/complete_multipart866niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/complete_multipart867niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody/request_more_parts868niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/request_more_parts869niks3-go-unit-tests> === CONT  TestUploadHandlersRejectOversizedBody/create_pending_closure870niks3-go-unit-tests> === CONT  TestUploadHandlersRejectOversizedBody/request_more_parts871niks3-go-unit-tests> 2026/06/28 12:18:46 INFO Received uploads request method=POST path=/872niks3-go-unit-tests> 2026/06/28 12:18:46 INFO Received request for more parts method=POST path=/873niks3-go-unit-tests> === CONT  TestUploadHandlersRejectOversizedBody/complete_multipart874niks3-go-unit-tests> 2026/06/28 12:18:46 INFO Received complete multipart upload request method=POST path=/875niks3-go-unit-tests> 2026/06/28 12:18:46 WARN Request failed, retrying attempt=2 max_attempts=6 backoff=209.397258ms error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures876niks3-go-unit-tests> 2026-06-28 12:18:46.848 UTC [1303] ERROR:  relation "goose_db_version" does not exist at character 36877niks3-go-unit-tests> 2026-06-28 12:18:46.848 UTC [1303] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC878niks3-go-unit-tests> 2026-06-28 12:18:46.848 UTC [1304] ERROR:  relation "goose_db_version" does not exist at character 36879niks3-go-unit-tests> 2026-06-28 12:18:46.848 UTC [1304] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC880niks3-go-unit-tests> 2026-06-28 12:18:46.849 UTC [1305] ERROR:  relation "goose_db_version" does not exist at character 36881niks3-go-unit-tests> 2026-06-28 12:18:46.849 UTC [1305] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC882niks3-go-unit-tests> 2026-06-28 12:18:46.872 UTC [1306] ERROR:  relation "goose_db_version" does not exist at character 36883niks3-go-unit-tests> 2026-06-28 12:18:46.872 UTC [1306] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC884niks3-go-unit-tests> 2026-06-28 12:18:46.873 UTC [1307] ERROR:  relation "goose_db_version" does not exist at character 36885niks3-go-unit-tests> 2026-06-28 12:18:46.873 UTC [1307] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC886niks3-go-unit-tests> 2026-06-28 12:18:46.874 UTC [1308] ERROR:  relation "goose_db_version" does not exist at character 36887niks3-go-unit-tests> 2026-06-28 12:18:46.874 UTC [1308] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC888niks3-go-unit-tests> 2026-06-28 12:18:46.877 UTC [1309] ERROR:  relation "goose_db_version" does not exist at character 36889niks3-go-unit-tests> 2026-06-28 12:18:46.877 UTC [1309] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC890niks3-go-unit-tests> 2026-06-28 12:18:46.880 UTC [1310] ERROR:  relation "goose_db_version" does not exist at character 36891niks3-go-unit-tests> 2026-06-28 12:18:46.880 UTC [1310] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC892niks3-go-unit-tests> 2026/06/28 12:18:46 WARN Request failed, retrying attempt=3 max_attempts=6 backoff=439.687069ms error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures893niks3-go-unit-tests> 2026-06-28 12:18:46.883 UTC [1311] ERROR:  relation "goose_db_version" does not exist at character 36894niks3-go-unit-tests> 2026-06-28 12:18:46.883 UTC [1311] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC895niks3-go-unit-tests> 2026-06-28 12:18:46.896 UTC [1312] ERROR:  relation "goose_db_version" does not exist at character 36896niks3-go-unit-tests> 2026-06-28 12:18:46.896 UTC [1312] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC897niks3-go-unit-tests> 2026-06-28 12:18:46.900 UTC [1313] ERROR:  relation "goose_db_version" does not exist at character 36898niks3-go-unit-tests> 2026-06-28 12:18:46.900 UTC [1313] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC899niks3-go-unit-tests> 2026-06-28 12:18:46.921 UTC [1314] ERROR:  relation "goose_db_version" does not exist at character 36900niks3-go-unit-tests> 2026-06-28 12:18:46.921 UTC [1314] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC901niks3-go-unit-tests> 2026-06-28 12:18:46.925 UTC [1315] ERROR:  relation "goose_db_version" does not exist at character 36902niks3-go-unit-tests> 2026-06-28 12:18:46.925 UTC [1315] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC903niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20241026095416_initial_model.sql (59.07ms)904niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20251210153512_drop_unused_gin_index.sql (5.29ms)905niks3-go-unit-tests> 2026-06-28 12:18:46.979 UTC [1316] ERROR:  relation "goose_db_version" does not exist at character 36906niks3-go-unit-tests> 2026-06-28 12:18:46.979 UTC [1316] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC907niks3-go-unit-tests> 2026-06-28 12:18:46.981 UTC [1317] ERROR:  relation "goose_db_version" does not exist at character 36908niks3-go-unit-tests> 2026-06-28 12:18:46.981 UTC [1317] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC909niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20251218171726_add_pins.sql (49.08ms)910niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20241026095416_initial_model.sql (112.45ms)911niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20251210153512_drop_unused_gin_index.sql (5.53ms)912niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20241026095416_initial_model.sql (120.83ms)913niks3-go-unit-tests> 2026-06-28 12:18:46.992 UTC [1318] ERROR:  relation "goose_db_version" does not exist at character 36914niks3-go-unit-tests> 2026-06-28 12:18:46.992 UTC [1318] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC915niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20241026095416_initial_model.sql (92.67ms)916niks3-go-unit-tests> 2026-06-28 12:18:46.997 UTC [1319] ERROR:  relation "goose_db_version" does not exist at character 36917niks3-go-unit-tests> 2026-06-28 12:18:46.997 UTC [1319] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC918niks3-go-unit-tests> 2026/06/28 12:18:46 OK   20251210153512_drop_unused_gin_index.sql (7.99ms)919niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (17.52ms)920niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000921niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (7.14ms)922niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (90.39ms)923niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (79.5ms)924niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (6.62ms)925niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (100.82ms)926niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (5.12ms)927niks3-go-unit-tests> 2026-06-28 12:18:47.009 UTC [1320] ERROR:  relation "goose_db_version" does not exist at character 36928niks3-go-unit-tests> 2026-06-28 12:18:47.009 UTC [1320] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC929niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (29.03ms)930niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (13.95ms)931niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 2932niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (16.12ms)933niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (14.23ms)934niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (113.51ms)935niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (26.2ms)936niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (116.79ms)937niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (6.3ms)938niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (29.69ms)939niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (102.15ms)940niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (5.12ms)941niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (25.96ms)942niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (9.58ms)943niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000944niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (79.51ms)945niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (18.54ms)946niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000947niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (4.41ms)948niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (16.01ms)949niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (16.15ms)950niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (120.21ms)951niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (6.09ms)952niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (8.84ms)953niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.1ms)954niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (10.43ms)955niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000956niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (4.83ms)957niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (5.85ms)958niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (13.42ms)959niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (10.22ms)960niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000961niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (4.32ms)962niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (80.4ms)963niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (4.43ms)964niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 2965niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (10.52ms)966niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (4.68ms)967niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 2968niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (11.03ms)969niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000970niks3-go-unit-tests> {"timestamp":"2026-06-28T12:18:47.053900556Z","level":"ERROR","fields":{"message":"system path read failed","path_kind":"data_usage","operation":"read_primary","reason":"config_not_found","object":"buckets/.usage.json","error":"Config not found"},"target":"rustfs_ecstore::data_usage","filename":"crates/ecstore/src/data_usage.rs","line_number":126,"threadName":"rustfs-worker","threadId":"ThreadId(766)"}971niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Created nix-cache-info in bucket bucket=bucket3972niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (11.49ms)973niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 2974niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (15.96ms)975niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (13.13ms)976niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (19.24ms)977niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000978niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (11.71ms)979niks3-go-unit-tests> 2026-06-28 12:18:47.059 UTC [1321] ERROR:  relation "goose_db_version" does not exist at character 36980niks3-go-unit-tests> 2026-06-28 12:18:47.059 UTC [1321] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC981niks3-go-unit-tests> 2026-06-28 12:18:47.059 UTC [1322] ERROR:  relation "goose_db_version" does not exist at character 36982niks3-go-unit-tests> 2026-06-28 12:18:47.059 UTC [1322] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC983niks3-go-unit-tests> 2026-06-28 12:18:47.060 UTC [1323] ERROR:  relation "goose_db_version" does not exist at character 36984niks3-go-unit-tests> 2026-06-28 12:18:47.060 UTC [1323] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC985niks3-go-unit-tests> --- PASS: TestReadProxyRangeRequest (0.62s)986niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (20.65ms)987niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (12.75ms)988niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (20.42ms)989niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (14.64ms)990niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000991niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (55.4ms)992niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000993niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (56.61ms)994niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (33.62ms)995niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (19.43ms)996niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 20260628120000997niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (6.34ms)998niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 2999niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (6.33ms)1000niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (6.52ms)1001niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001002niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (6.29ms)1003niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (30.23ms)1004niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (41.59ms)1005niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.94ms)1006niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21007niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.27ms)1008niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21009niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.98ms)1010niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.95ms)1011niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (4.1ms)1012niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (4.23ms)1013niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1014niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1015niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1016niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (5.09ms)1017niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (5.16ms)1018niks3-go-unit-tests> --- PASS: TestObjectStatsTrigger (0.63s)1019niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.32ms)1020niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.57ms)1021niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (4.19ms)1022niks3-go-unit-tests> --- PASS: TestReadProxyNarStreaming (0.63s)1023niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.8ms)1024niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21025niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (7.19ms)1026niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001027niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.91ms)1028niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21029niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (3.84ms)1030niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.95ms)1031niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21032niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.02ms)1033niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21034niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Created nix-cache-info in bucket bucket=bucket61035niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.7ms)1036niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (7.24ms)1037niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001038niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.67ms)1039niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.58ms)1040niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (5.65ms)1041niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Created nix-cache-info in bucket bucket=bucket71042niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.72ms)1043niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.19ms)1044niks3-go-unit-tests> 2026/06/28 12:18:47 WARN mTLS auth: subject not in bound subjects subject="CN=untrusted,O=Other"1045niks3-go-unit-tests> 2026/06/28 12:18:47 WARN mTLS auth: bound subjects configured but subject DN unavailable1046niks3-go-unit-tests> 2026/06/28 12:18:47 WARN mTLS auth: subject not in bound subjects subject="CN=untrusted"1047niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_MTLSBoundSubjects (0.63s)1048niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Created nix-cache-info in bucket bucket=bucket111049niks3-go-unit-tests> 2026-06-28 12:18:47.075 UTC [1325] ERROR:  relation "goose_db_version" does not exist at character 361050niks3-go-unit-tests> 2026-06-28 12:18:47.075 UTC [1325] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1051niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.44ms)1052niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21053niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (3.04ms)1054niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21055niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (5.86ms)1056niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001057niks3-go-unit-tests> 2026-06-28 12:18:47.077 UTC [1326] ERROR:  relation "goose_db_version" does not exist at character 361058niks3-go-unit-tests> 2026-06-28 12:18:47.077 UTC [1326] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1059niks3-go-unit-tests> 2026-06-28 12:18:47.077 UTC [1329] ERROR:  relation "goose_db_version" does not exist at character 361060niks3-go-unit-tests> 2026-06-28 12:18:47.077 UTC [1329] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1061niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.99ms)1062niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (5.09ms)1063niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (5.07ms)1064niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001065niks3-go-unit-tests> 2026-06-28 12:18:47.077 UTC [1327] ERROR:  relation "goose_db_version" does not exist at character 361066niks3-go-unit-tests> 2026-06-28 12:18:47.077 UTC [1327] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1067niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001068niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001069niks3-go-unit-tests> 2026-06-28 12:18:47.079 UTC [1330] ERROR:  relation "goose_db_version" does not exist at character 361070niks3-go-unit-tests> 2026-06-28 12:18:47.079 UTC [1330] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1071niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (7.41ms)1072niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001073niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (9.93ms)1074niks3-go-unit-tests> 2026/06/28 12:18:47 WARN mTLS auth: subject not in bound subjects subject="CN=reader"1075niks3-go-unit-tests> 2026/06/28 12:18:47 WARN mTLS auth: subject not in bound subjects subject="CN=writer"1076niks3-go-unit-tests> --- PASS: TestService_NativeMTLS (0.64s)1077niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (10.15ms)1078niks3-go-unit-tests> 2026-06-28 12:18:47.080 UTC [1331] ERROR:  relation "goose_db_version" does not exist at character 361079niks3-go-unit-tests> 2026-06-28 12:18:47.080 UTC [1331] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1080niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.68ms)1081niks3-go-unit-tests> 2026-06-28 12:18:47.080 UTC [1335] ERROR:  relation "goose_db_version" does not exist at character 361082niks3-go-unit-tests> 2026-06-28 12:18:47.080 UTC [1335] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1083niks3-go-unit-tests> 2026-06-28 12:18:47.080 UTC [1333] ERROR:  relation "goose_db_version" does not exist at character 361084niks3-go-unit-tests> 2026-06-28 12:18:47.080 UTC [1333] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1085niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.14ms)1086niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.06ms)1087niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.12ms)1088niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (10.08ms)1089niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.36ms)1090niks3-go-unit-tests> 2026-06-28 12:18:47.082 UTC [1336] ERROR:  relation "goose_db_version" does not exist at character 361091niks3-go-unit-tests> 2026-06-28 12:18:47.082 UTC [1336] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1092niks3-go-unit-tests> 2026-06-28 12:18:47.082 UTC [1338] ERROR:  relation "goose_db_version" does not exist at character 361093niks3-go-unit-tests> 2026-06-28 12:18:47.082 UTC [1338] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1094niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.08ms)1095niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.01ms)1096niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.49ms)1097niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.47ms)1098niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21099niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21100niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.46ms)1101niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21102niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.14ms)1103niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21104niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1342] ERROR:  relation "goose_db_version" does not exist at character 361105niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1342] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1106niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1340] ERROR:  relation "goose_db_version" does not exist at character 361107niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1340] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1108niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1339] ERROR:  relation "goose_db_version" does not exist at character 361109niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1339] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1110niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.66ms)1111niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1344] ERROR:  relation "goose_db_version" does not exist at character 361112niks3-go-unit-tests> 2026-06-28 12:18:47.083 UTC [1344] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1113niks3-go-unit-tests> 2026-06-28 12:18:47.084 UTC [1345] ERROR:  relation "goose_db_version" does not exist at character 361114niks3-go-unit-tests> 2026-06-28 12:18:47.084 UTC [1345] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1115niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.83ms)1116niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21117niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (3.18ms)1118niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1119niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1120niks3-go-unit-tests> --- PASS: TestReadProxyDisabled (0.65s)1121niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.18ms)1122niks3-go-unit-tests> 2026-06-28 12:18:47.086 UTC [1363] ERROR:  relation "goose_db_version" does not exist at character 361123niks3-go-unit-tests> 2026-06-28 12:18:47.086 UTC [1363] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1124niks3-go-unit-tests> 2026-06-28 12:18:47.086 UTC [1362] ERROR:  relation "goose_db_version" does not exist at character 361125niks3-go-unit-tests> 2026-06-28 12:18:47.086 UTC [1362] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1126niks3-go-unit-tests> 2026-06-28 12:18:47.086 UTC [1350] ERROR:  relation "goose_db_version" does not exist at character 361127niks3-go-unit-tests> 2026-06-28 12:18:47.086 UTC [1350] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1128niks3-go-unit-tests> 2026-06-28 12:18:47.087 UTC [1364] ERROR:  relation "goose_db_version" does not exist at character 361129niks3-go-unit-tests> 2026-06-28 12:18:47.087 UTC [1364] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1130niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1131niks3-go-unit-tests> 2026-06-28 12:18:47.087 UTC [1365] ERROR:  relation "goose_db_version" does not exist at character 361132niks3-go-unit-tests> 2026-06-28 12:18:47.087 UTC [1365] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1133niks3-go-unit-tests> --- PASS: TestReadProxyRootRedirectsToIndexHTML (0.65s)1134niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.75ms)1135niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.85ms)1136niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001137niks3-go-unit-tests> 2026-06-28 12:18:47.090 UTC [1368] ERROR:  relation "goose_db_version" does not exist at character 361138niks3-go-unit-tests> 2026-06-28 12:18:47.090 UTC [1368] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1139niks3-go-unit-tests> 2026/06/28 12:18:47 ERROR Multipart upload not found error="no rows in result set" upload_id=does-not-exist object_key=nar/0000000000000000000000000000000000000000000000000000.nar.zst1140niks3-go-unit-tests> --- PASS: TestCompleteMultipartUnregistered (0.65s)1141niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (5.14ms)1142niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001143niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug1144niks3-go-unit-tests>     metadata_upload_test.go:48: First store path: /build/TestNARDeduplicationMetadataUploadBug827833443/001/store/jiz66wrdznzzzmqcswhzl4z0swb55rwv-file1.txt1145niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.37ms)1146niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.54ms)1147niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001148niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.31ms)1149niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.95ms)1150niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21151niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (10.15ms)1152niks3-go-unit-tests> --- PASS: TestMetricsInventory (0.66s)1153niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (11.85ms)1154niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.42ms)1155niks3-go-unit-tests> --- PASS: TestCreatePendingClosure_SmallNARUsesSimplePUT (0.66s)1156niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.38ms)1157niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21158niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.58ms)1159niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21160niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.04ms)1161niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.09ms)1162niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (11.09ms)1163niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (11.21ms)1164niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (11.77ms)1165niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (10.93ms)1166niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (10.05ms)1167niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1168niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_MTLSProxyHeader (0.65s)1169niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.37ms)1170niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.35ms)1171niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (3.76ms)1172niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (12.14ms)1173niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (13.81ms)1174niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (5.58ms)1175niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (7.19ms)1176niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (12.36ms)1177niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (7.16ms)1178niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (7.21ms)1179niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (15.43ms)1180niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (11.41ms)1181niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (15.27ms)1182niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (17.32ms)1183niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (12.99ms)1184niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (15.19ms)1185niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (7.82ms)1186niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (16.38ms)1187niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (12.75ms)1188niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (12.33ms)1189niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (6.66ms)1190niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (3.72ms)1191niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (6.85ms)1192niks3-go-unit-tests> === NAME  TestClientIntegration1193niks3-go-unit-tests>     client_integration_test.go:276: Created store path: /build/TestClientIntegration885605021/002/store/1rsqz8kdcczh9ijz1mqbd0aar0ww89z4-test-file.txt1194niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (5.21ms)1195niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (14.32ms)1196niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (1.73ms)1197niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (1.81ms)1198niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.13ms)1199niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (1.93ms)1200niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.23ms)1201niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.43ms)1202niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.17ms)1203niks3-go-unit-tests> === NAME  TestClientMultipleUploads1204niks3-go-unit-tests>     client_integration_test.go:338: Created store path 0: /build/TestClientMultipleUploads2560991565/001/store/wl1s4gf04mbldc3k6gmb55vvdl8fsb6m-test-file-0.txt1205niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.7ms)1206niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.56ms)1207niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.58ms)1208niks3-go-unit-tests> --- PASS: TestResurrectedObjectNotDeleted (0.67s)1209niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (1.89ms)1210niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (2.57ms)1211niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.53ms)1212niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001213niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.65ms)1214niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.44ms)1215niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.39ms)1216niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.2ms)1217niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (5.01ms)1218niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001219niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001220niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001221niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.38ms)1222niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (5.36ms)1223niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001224niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001225niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.44ms)1226niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.55ms)1227niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.22ms)1228niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.29ms)1229niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.7ms)1230niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (4.32ms)1231niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (5.64ms)1232niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (5.35ms)1233niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (5.47ms)1234niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.47ms)1235niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (7.73ms)1236niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (5.67ms)1237niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.03ms)1238niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.03ms)1239niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.71ms)1240niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (5.93ms)1241niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (6.56ms)1242niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.39ms)1243niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001244niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1245niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.28ms)1246niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001247niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.45ms)1248niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001249niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.53ms)1250niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001251niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.92ms)1252niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001253niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.57ms)1254niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21255niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.89ms)1256niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.56ms)1257niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21258niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21259niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.87ms)1260niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2ms)1261niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21262niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.43ms)1263niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.62ms)1264niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.29ms)1265niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.3ms)1266niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.59ms)1267niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (2.21ms)1268niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21269niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20241026095416_initial_model.sql (14.61ms)1270niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.11ms)1271niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21272niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.24ms)1273niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001274niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.54ms)1275niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001276niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.26ms)1277niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001278niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.03ms)1279niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.28ms)1280niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001281niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.5ms)1282niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.44ms)1283niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001284niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.01ms)1285niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001286niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21287niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.04ms)1288niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21289niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.24ms)1290niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21291niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21292niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.39ms)1293niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001294niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.16ms)1295niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21296niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.52ms)1297niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001298niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (4.26ms)1299niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001300niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251210153512_drop_unused_gin_index.sql (1.28ms)1301niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1302niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.6ms)1303niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.73ms)1304niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.65ms)1305niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.83ms)1306niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.81ms)1307niks3-go-unit-tests> --- PASS: TestService_Rustfstest (0.68s)1308niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (2.46ms)1309niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.66ms)1310niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.64ms)1311niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (1.73ms)1312niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received cleanup request method=DELETE path=/api/pending_closures1313niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (756.5µs)1314niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21315niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (963.03µs)1316niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21317niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1ms)1318niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21319niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (937.89µs)1320niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21321niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (918.26µs)1322niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21323niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (981.39µs)1324niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21325niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20251218171726_add_pins.sql (2.36ms)1326niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (915.26µs)1327niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21328niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.11ms)1329niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21330niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.08ms)1331niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21332niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Aborted multipart uploads count=01333niks3-go-unit-tests> --- PASS: TestService_healthCheckHandler (0.68s)1334niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1335niks3-go-unit-tests> 2026/06/28 12:18:47 OK   20260628120000_add_object_size_and_stats.sql (3.36ms)1336niks3-go-unit-tests> 2026/06/28 12:18:47 goose: successfully migrated database to version: 202606281200001337niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Created nix-cache-info in bucket bucket=bucket311338niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1339niks3-go-unit-tests> 2026/06/28 12:18:47 OK   1_commit_pending_closure.sql (3.32ms)1340niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1341niks3-go-unit-tests> 2026/06/28 12:18:47 OK   2_object_stats_trigger.sql (1.38ms)1342niks3-go-unit-tests> 2026/06/28 12:18:47 goose: up to current file version: 21343niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/valid_OIDC_token1344niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/valid_OIDC_token1345niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected1346niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected1347niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/malformed_token_rejected1348niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/malformed_token_rejected1349niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured1350niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured1351niks3-go-unit-tests> --- PASS: TestReadProxyNarinfo (0.69s)1352niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected1353niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_OIDC/valid_OIDC_token1354niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured1355niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_OIDC/malformed_token_rejected1356niks3-go-unit-tests> 2026/06/28 12:18:47 WARN mTLS auth: subject not in bound subjects subject="CN=writer"1357niks3-go-unit-tests> --- PASS: TestService_ReadAuthMiddleware (0.69s)1358niks3-go-unit-tests> --- PASS: TestReadProxyNarinfoAlreadyDecompressed (0.69s)1359niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Authentication failed token_preview=wrongtoken token_length=10 reason="static API token mismatch"1360niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware (0.70s)1361niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Authentication failed token_preview=not-a-valid-jwt token_length=15 oidc_error="no provider could verify the token (signature or issuer mismatch)" oidc_provider="" tried_providers=[test]1362niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Aborted multipart uploads count=01363niks3-go-unit-tests> === NAME  TestPinProtectsFromGC1364niks3-go-unit-tests>     client_integration_test.go:646: Pinned store path: /build/TestPinProtectsFromGC897560615/001/store/q54f4bfd4a2s1s9bhna76yfssvxxhk8i-pinned-file.txt1365niks3-go-unit-tests>     client_integration_test.go:647: Unpinned store path: /build/TestPinProtectsFromGC897560615/001/store/6jidgkw13mnrwcxznk1c57fnpmc3i6h3-unpinned-file.txt1366niks3-go-unit-tests> === NAME  TestClientMultipleUploads1367niks3-go-unit-tests>     client_integration_test.go:338: Created store path 1: /build/TestClientMultipleUploads2560991565/001/store/ylq6yiybaaxcynm95n7xchx9n5nb1bbm-test-file-1.txt1368niks3-go-unit-tests> --- PASS: TestReadProxy404 (0.70s)1369niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Created nix-cache-info in bucket bucket=bucket371370niks3-go-unit-tests> 2026/06/28 12:18:47 INFO OIDC auth successful provider=test1371niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Force mode enabled - objects will be deleted immediately without grace period1372niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Authentication failed token_preview=eyJhbGciOi...imM3yQKACg token_length=702 oidc_error="bound claims validation failed: claim \"repository_owner\" value [otherorg] not in allowed patterns [myorg]" oidc_provider=test tried_providers=[test]1373niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_OIDC (0.70s)1374niks3-go-unit-tests>     --- PASS: TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured (0.00s)1375niks3-go-unit-tests>     --- PASS: TestService_AuthMiddleware_OIDC/malformed_token_rejected (0.00s)1376niks3-go-unit-tests>     --- PASS: TestService_AuthMiddleware_OIDC/valid_OIDC_token (0.00s)1377niks3-go-unit-tests>     --- PASS: TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected (0.00s)1378niks3-go-unit-tests> --- PASS: TestReadProxyInvalidPath (0.69s)1379niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received cleanup request method=DELETE path=/api/pending_closures1380niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Aborted multipart uploads count=11381niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Garbage collection completed failed-uploads-deleted=0 old-closures-deleted=0 objects-marked-for-deletion=0 objects-deleted-after-grace-period=0 objects-failed-to-delete=01382niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1383niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_closures1384niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_objects1385niks3-go-unit-tests> 2026-06-28 12:18:47.148 UTC [1340] ERROR:  Closure does not exist: id=11386niks3-go-unit-tests> 2026-06-28 12:18:47.148 UTC [1340] CONTEXT:  PL/pgSQL function commit_pending_closure(bigint) line 16 at RAISE1387niks3-go-unit-tests> 2026-06-28 12:18:47.148 UTC [1340] STATEMENT:  -- name: CommitPendingClosure :exec1388niks3-go-unit-tests> 	SELECT commit_pending_closure($1::bigint)1389niks3-go-unit-tests> 	1390niks3-go-unit-tests> --- PASS: TestService_cleanupPendingClosuresHandler (0.70s)1391niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=multipart_uploads1392niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=closures1393niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=objects1394niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1395niks3-go-unit-tests> --- PASS: TestGCMetrics (0.71s)1396niks3-go-unit-tests> {"timestamp":"2026-06-28T12:18:47.15276955Z","level":"ERROR","fields":{"message":"complete_multipart_upload part error: \"part.1 not found\""},"target":"rustfs_ecstore::set_disk","filename":"crates/ecstore/src/set_disk.rs","line_number":3463,"threadName":"rustfs-worker","threadId":"ThreadId(696)"}1397niks3-go-unit-tests> {"timestamp":"2026-06-28T12:18:47.15280207Z","level":"ERROR","fields":{"message":"complete_multipart_upload etag err client=Some(\"deadbeef\"), stored=\"\", part_id=1, bucket=bucket41, object=nar/gggggggggggggggggggggggggggggg0300000000000000000000.nar.zst"},"target":"rustfs_ecstore::set_disk","filename":"crates/ecstore/src/set_disk.rs","line_number":3534,"threadName":"rustfs-worker","threadId":"ThreadId(696)"}1398niks3-go-unit-tests> 2026/06/28 12:18:47 WARN CompleteMultipartUpload errored but object exists; treating as success error="One or more of the specified parts could not be found.  The part may not have been uploaded, or the specified entity tag may not match the part's entity tag." object_key=nar/gggggggggggggggggggggggggggggg0300000000000000000000.nar.zst upload_id=M2UzODdmMjQtMzFkYi00MDkyLTkyZTAtMDUyNWU5YmNkNmFmLjhiNGZmY2ZlLWYzYWQtNDBlMy04NjkwLTdiZWRkOTE5NWFkOHgxNzgyNjQ5MTI3MTQyMzkzMTI31399niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed multipart upload object_key=nar/gggggggggggggggggggggggggggggg0300000000000000000000.nar.zst upload_id=M2UzODdmMjQtMzFkYi00MDkyLTkyZTAtMDUyNWU5YmNkNmFmLjhiNGZmY2ZlLWYzYWQtNDBlMy04NjkwLTdiZWRkOTE5NWFkOHgxNzgyNjQ5MTI3MTQyMzkzMTI3 parts=11400niks3-go-unit-tests> --- PASS: TestCompleteMultipartUpload_ErrorButObjectExists (0.71s)1401niks3-go-unit-tests> === NAME  TestClientMultipleUploads1402niks3-go-unit-tests>     client_integration_test.go:338: Created store path 2: /build/TestClientMultipleUploads2560991565/001/store/rxb6vfnf9hk2xdfhbzd292k9snp2ndsb-test-file-2.txt1403niks3-go-unit-tests> === NAME  TestClientCADerivations1404niks3-go-unit-tests>     client_ca_test.go:136: Built CA derivation: /build/TestClientCADerivations2819997664/001/store/0cpb832v1cmkkfcyz22ppmpa63r3cmhg-ca-test1405niks3-go-unit-tests> === NAME  TestClientWithDependencies1406niks3-go-unit-tests>     client_integration_test.go:593: Built derivation: /build/TestClientWithDependencies1145645421/001/store/0y39cv6h2blfi6p80qqng1kihddqgkwq-test-script1407niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received cleanup request method=DELETE path=/api/pending_closures1408niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectOversizedBody (0.18s)1409niks3-go-unit-tests>     --- PASS: TestUploadHandlersRejectOversizedBody/complete_multipart (0.06s)1410niks3-go-unit-tests>     --- PASS: TestUploadHandlersRejectOversizedBody/request_more_parts (0.06s)1411niks3-go-unit-tests>     --- PASS: TestUploadHandlersRejectOversizedBody/create_pending_closure (0.73s)1412niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Request failed, retrying attempt=4 max_attempts=6 backoff=855.672633ms error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures1413niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1414niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1415niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Aborted multipart uploads count=11416niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1417niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1rsqz8kdcczh9ijz1mqbd0aar0ww89z4-test-file.txt (152B)1418niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1419niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading jiz66wrdznzzzmqcswhzl4z0swb55rwv-file1.txt (160B)1420niks3-go-unit-tests> --- PASS: TestMultipartCleanup (0.93s)1421niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1422niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=1 count=11423niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 narinfos1424niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1425niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=1 count=11426niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 narinfos1427niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1428niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1429niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11430niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (236ms)1431niks3-go-unit-tests> === NAME  TestClientIntegration1432niks3-go-unit-tests>     client_integration_test.go:292: Retrieved narinfo from S3:1433niks3-go-unit-tests>         StorePath: /build/TestClientIntegration885605021/002/store/1rsqz8kdcczh9ijz1mqbd0aar0ww89z4-test-file.txt1434niks3-go-unit-tests>         URL: nar/11l1b7hsy9g9pz8i2rcn4n128l6pyr2yf58d49r12hr5caw9dzk1.nar.zst1435niks3-go-unit-tests>         Compression: zstd1436niks3-go-unit-tests>         NarHash: sha256:11l1b7hsy9g9pz8i2rcn4n128l6pyr2yf58d49r12hr5caw9dzk11437niks3-go-unit-tests>         NarSize: 1521438niks3-go-unit-tests>         References: 1439niks3-go-unit-tests>         CA: fixed:r:sha256:11l1b7hsy9g9pz8i2rcn4n128l6pyr2yf58d49r12hr5caw9dzk11440niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11441niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (261ms)1442niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug1443niks3-go-unit-tests>     metadata_upload_test.go:54: Retrieved narinfo from S3:1444niks3-go-unit-tests>         StorePath: /build/TestNARDeduplicationMetadataUploadBug827833443/001/store/jiz66wrdznzzzmqcswhzl4z0swb55rwv-file1.txt1445niks3-go-unit-tests>         URL: nar/1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf.nar.zst1446niks3-go-unit-tests>         Compression: zstd1447niks3-go-unit-tests>         NarHash: sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1448niks3-go-unit-tests>         NarSize: 1601449niks3-go-unit-tests>         References: 1450niks3-go-unit-tests>         CA: fixed:r:sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1451niks3-go-unit-tests> === NAME  TestClientIntegration1452niks3-go-unit-tests>     client_integration_test.go:293: Retrieved .ls file from S3 (compressed size: 77 bytes)1453niks3-go-unit-tests>     client_integration_test.go:293: Decompressed .ls content (64 bytes):1454niks3-go-unit-tests>         {"version":1,"root":{"type":"regular","size":39,"narOffset":96}}1455niks3-go-unit-tests>     client_integration_test.go:296: Testing garbage collection...1456niks3-go-unit-tests> === NAME  TestClientWithDependencies1457niks3-go-unit-tests>     client_integration_test.go:595: Found 1 dependencies (including self)1458niks3-go-unit-tests> === NAME  TestClientCADerivations1459niks3-go-unit-tests>     client_ca_test.go:139: Found 1 dependencies (including self)1460niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug1461niks3-go-unit-tests>     metadata_upload_test.go:55: Retrieved .ls file from S3 (compressed size: 77 bytes)1462niks3-go-unit-tests>     metadata_upload_test.go:55: Decompressed .ls content (64 bytes):1463niks3-go-unit-tests>         {"version":1,"root":{"type":"regular","size":44,"narOffset":96}}1464niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1465niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1466niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1467niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading q54f4bfd4a2s1s9bhna76yfssvxxhk8i-pinned-file.txt (128B)1468niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1469niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=1 count=11470niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 narinfos1471niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1472niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11473niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (241ms)1474niks3-go-unit-tests>     metadata_upload_test.go:64: Second store path (same content): /build/TestNARDeduplicationMetadataUploadBug827833443/001/store/vgwkm0r37z4mqvdbwyf05v7amgimn8jf-file2.txt1475niks3-go-unit-tests> === NAME  TestOrphanedObjectsGC1476niks3-go-unit-tests>     orphaned_objects_gc_test.go:290: GC Test Summary:1477niks3-go-unit-tests>     orphaned_objects_gc_test.go:291:   - Kept:    2 objects from closure A1478niks3-go-unit-tests>     orphaned_objects_gc_test.go:292:   - Deleted: 2 objects from closure B1479niks3-go-unit-tests>     orphaned_objects_gc_test.go:293:   - Deleted: 6 orphaned chain objects (X1->X2->X3)1480niks3-go-unit-tests>     orphaned_objects_gc_test.go:294:   - Deleted: 2 orphaned single objects (Y)1481niks3-go-unit-tests>     orphaned_objects_gc_test.go:295:   - Total deleted: 10 objects1482niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Starting cleanup of old closures method=DELETE path=/api/closures1483niks3-go-unit-tests> --- PASS: TestOrphanedObjectsGC (0.97s)1484niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Garbage collection started1485niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Authentication failed token_preview=invalid-token token_length=13 reason="static API token mismatch"1486niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1487niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Aborted multipart uploads count=01488niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Force mode enabled - objects will be deleted immediately without grace period1489niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1490niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1491niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 3 paths to 127.0.0.1 (0 already cached)1492niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading ylq6yiybaaxcynm95n7xchx9n5nb1bbm-test-file-1.txt (160B)1493niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading rxb6vfnf9hk2xdfhbzd292k9snp2ndsb-test-file-2.txt (160B)1494niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading wl1s4gf04mbldc3k6gmb55vvdl8fsb6m-test-file-0.txt (160B)1495niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/3/sign1496niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=3 count=11497niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1498niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=1 count=11499niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign1500niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=2 count=11501niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 3 narinfos1502niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1503niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=21504niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/3/complete1505niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=31506niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1507niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11508niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (91ms)1509niks3-go-unit-tests> === NAME  TestClientMultipleUploads1510niks3-go-unit-tests>     client_integration_test.go:349: Uploaded 3 paths in 277.044646ms1511niks3-go-unit-tests> --- PASS: TestClientMultipleUploads (1.02s)1512niks3-go-unit-tests> --- PASS: TestGCBugBareHashReferences (1.02s)1513niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1514niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1515niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 0y39cv6h2blfi6p80qqng1kihddqgkwq-test-script (136B)1516niks3-go-unit-tests> --- PASS: TestReadProxyHead (1.03s)1517niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1518niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1519niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=1 count=11520niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 narinfos1521niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1522niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1523niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 0cpb832v1cmkkfcyz22ppmpa63r3cmhg-ca-test (144B)1524niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11525niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (65ms)1526niks3-go-unit-tests> === NAME  TestClientWithDependencies1527niks3-go-unit-tests>     client_integration_test.go:597: Skipping nix copy test - isolated store (/build/TestClientWithDependencies1145645421/001/store) requires matching store prefix1528niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1529niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=1 count=11530niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 narinfos1531niks3-go-unit-tests> --- PASS: TestClientWithDependencies (1.05s)1532niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1533niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11534niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (72ms)1535niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1536niks3-go-unit-tests> === NAME  TestClientCADerivations1537niks3-go-unit-tests>     client_ca_test.go:180: Narinfo contains CA field: StorePath: /build/TestClientCADerivations2819997664/001/store/0cpb832v1cmkkfcyz22ppmpa63r3cmhg-ca-test1538niks3-go-unit-tests>         URL: nar/04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n.nar.zst1539niks3-go-unit-tests>         Compression: zstd1540niks3-go-unit-tests>         NarHash: sha256:04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n1541niks3-go-unit-tests>         NarSize: 1441542niks3-go-unit-tests>         References: 1543niks3-go-unit-tests>         Deriver: /build/TestClientCADerivations2819997664/001/store/pis61xvk1pwvbqj79gd4sms56zm8r5c9-ca-test.drv1544niks3-go-unit-tests>         CA: fixed:r:sha256:04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n1545niks3-go-unit-tests>     client_ca_test.go:185: Checking for realisation files in S3...1546niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1547niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 6jidgkw13mnrwcxznk1c57fnpmc3i6h3-unpinned-file.txt (128B)1548niks3-go-unit-tests>     client_ca_test.go:207: No realisation files uploaded - this is expected for locally built CA derivations1549niks3-go-unit-tests>     client_ca_test.go:208: Locally built CA derivations don't have DrvOutput IDs until they're substituted from a cache1550niks3-go-unit-tests> --- PASS: TestReadProxyConditionalGet (1.06s)1551niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign1552niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=2 count=11553niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 narinfos1554niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1555niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 0 paths to 127.0.0.1 (1 already cached)1556niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1557niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=21558niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign1559niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (69ms)1560niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Signed narinfos id=2 count=11561niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Uploading 1 narinfos1562niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1563niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=21564niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Upload complete. (66ms)1565niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug1566niks3-go-unit-tests>     metadata_upload_test.go:76: Retrieved narinfo from S3:1567niks3-go-unit-tests>         StorePath: /build/TestNARDeduplicationMetadataUploadBug827833443/001/store/vgwkm0r37z4mqvdbwyf05v7amgimn8jf-file2.txt1568niks3-go-unit-tests>         URL: nar/1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf.nar.zst1569niks3-go-unit-tests>         Compression: zstd1570niks3-go-unit-tests>         NarHash: sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1571niks3-go-unit-tests>         NarSize: 1601572niks3-go-unit-tests>         References: 1573niks3-go-unit-tests>         CA: fixed:r:sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1574niks3-go-unit-tests>     metadata_upload_test.go:77: Retrieved .ls file from S3 (compressed size: 62 bytes)1575niks3-go-unit-tests>     metadata_upload_test.go:77: Decompressed .ls content (49 bytes):1576niks3-go-unit-tests>         {"version":1,"root":{"type":"regular","size":44}}1577niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1578niks3-go-unit-tests> --- PASS: TestNARDeduplicationMetadataUploadBug (1.08s)1579niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed multipart upload object_key=nar/0000000000000000000000000000000000000000000000000000.nar.zst upload_id=M2UzODdmMjQtMzFkYi00MDkyLTkyZTAtMDUyNWU5YmNkNmFmLmQ3YTEyZDUwLTY3MjMtNGVmOC1iOTE4LWFlYjZkYWRkZTQ4MngxNzgyNjQ5MTI3MDc0Njk5ODAz parts=101580niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1581niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11582niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received get closure request method=GET path=/api/closures/000000000000000000000000000000001583niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1584niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Starting cleanup of old closures method=DELETE path=/api/closures1585niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Aborted multipart uploads count=01586niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received create pin request method=POST path=/api/pins/myapp1587niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Garbage collection completed failed-uploads-deleted=0 old-closures-deleted=1 objects-marked-for-deletion=2 objects-deleted-after-grace-period=0 objects-failed-to-delete=01588niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Created/updated pin name=myapp store_path=/build/TestPinProtectsFromGC897560615/001/store/q54f4bfd4a2s1s9bhna76yfssvxxhk8i-pinned-file.txt narinfo_key=q54f4bfd4a2s1s9bhna76yfssvxxhk8i.narinfo1589niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Starting cleanup of old closures method=DELETE path=/api/closures1590niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Garbage collection started1591niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_closures1592niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Aborted multipart uploads count=01593niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_objects1594niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=multipart_uploads1595niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1596niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Force mode enabled - objects will be deleted immediately without grace period1597niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=closures1598niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=objects1599niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed multipart upload object_key=nar/dadb44fdadb44fdadb44fdadb44f000000000000000000000000.nar.zst upload_id=M2UzODdmMjQtMzFkYi00MDkyLTkyZTAtMDUyNWU5YmNkNmFmLmZjNzgyYjYyLTQxZjktNGU0Ni05MDU4LTdhMWZjY2I0MWE3OXgxNzgyNjQ5MTI3MDkyNDk1NTI5 parts=101600niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1601niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed upload id=11602niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1603niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received uploads request method=POST path=/api/pending_closures1604niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Object in database but missing from S3 key=dadb44fdadb44fdadb44fdadb44f0000.narinfo1605niks3-go-unit-tests> 2026/06/28 12:18:47 WARN Found objects in DB but missing from S3, will re-upload count=11606niks3-go-unit-tests> --- PASS: TestService_verifyS3Integrity (1.12s)1607niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received get closure request method=GET path=/api/closures/000000000000000000000000000000001608niks3-go-unit-tests> --- PASS: TestService_createPendingClosureHandler (1.14s)1609niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1610niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Completed multipart upload object_key=nar/gggggggggggggggggggggggggggggg0100000000000000000000.nar.zst upload_id=M2UzODdmMjQtMzFkYi00MDkyLTkyZTAtMDUyNWU5YmNkNmFmLmMyMzQzNzgxLWM0NGUtNDUyMC04MTBjLWMwMGE2NzEwMTk0NXgxNzgyNjQ5MTI3MTExMzg5ODY2 parts=121611niks3-go-unit-tests> --- PASS: TestRedundantMultipartUpload (1.17s)1612niks3-go-unit-tests> === NAME  TestClientCADerivations1613niks3-go-unit-tests>     client_ca_test.go:258: nix copy output: warning: you don't have Internet access; disabling some network-dependent features1614niks3-go-unit-tests>         warning: failed to create TLS context for AWS credential providers; SSO, STS WebIdentity, and ECS container authentication will be unavailable1615niks3-go-unit-tests>         error: binary cache 's3://bucket31?endpoint=http://localhost:36893&region=eu-west-1' is for Nix stores with prefix '/nix/store', not '/build/TestClientCADerivations2819997664/001/store'1616niks3-go-unit-tests>     client_ca_test.go:259: nix copy failed (might be expected with isolated stores): exit status 11617niks3-go-unit-tests> --- PASS: TestClientCADerivations (1.18s)1618niks3-go-unit-tests> === NAME  TestOrphanedObjectsGCStressTest1619niks3-go-unit-tests>     orphaned_objects_gc_test.go:425: Created 10 active closures, 5 to-delete closures, 20 orphaned chains1620niks3-go-unit-tests>     orphaned_objects_gc_test.go:446: Marked 210 objects for deletion1621niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Garbage collection completed failed-uploads-deleted=0 old-closures-deleted=1 objects-marked-for-deletion=3 objects-deleted-after-grace-period=2001 objects-failed-to-delete=01622niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_closures1623niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_objects1624niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=multipart_uploads1625niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=closures1626niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=objects1627niks3-go-unit-tests>     orphaned_objects_gc_test.go:509: Stress test completed successfully:1628niks3-go-unit-tests>     orphaned_objects_gc_test.go:510:   - Active objects preserved: 201629niks3-go-unit-tests>     orphaned_objects_gc_test.go:511:   - Objects deleted: 2101630niks3-go-unit-tests>     orphaned_objects_gc_test.go:512:   - Total GC'd: 2101631niks3-go-unit-tests> --- PASS: TestOrphanedObjectsGCStressTest (1.50s)1632niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Garbage collection completed failed-uploads-deleted=0 old-closures-deleted=1 objects-marked-for-deletion=3 objects-deleted-after-grace-period=2001 objects-failed-to-delete=01633niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_closures1634niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=pending_objects1635niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=multipart_uploads1636niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=closures1637niks3-go-unit-tests> 2026/06/28 12:18:47 INFO Vacuumed table table=objects1638niks3-go-unit-tests> 2026/06/28 12:18:48 WARN Request failed, retrying attempt=5 max_attempts=6 backoff=1.478909594s error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures1639niks3-go-unit-tests> 2026/06/28 12:18:49 INFO Garbage collection progress phase="" failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=2001 objects_failed=01640niks3-go-unit-tests> === NAME  TestClientIntegration1641niks3-go-unit-tests>     client_integration_test.go:303: Objects in database after GC:1642niks3-go-unit-tests>     client_integration_test.go:303: Successfully deleted all objects with GC --force1643niks3-go-unit-tests> --- PASS: TestClientIntegration (2.99s)1644niks3-go-unit-tests> 2026/06/28 12:18:49 INFO Garbage collection progress phase="" failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=2001 objects_failed=01645niks3-go-unit-tests> === NAME  TestPinProtectsFromGC1646niks3-go-unit-tests>     client_integration_test.go:709: Pin successfully protected closure from garbage collection1647niks3-go-unit-tests> --- PASS: TestPinProtectsFromGC (3.11s)1648niks3-go-unit-tests> --- PASS: TestClientErrorHandling (0.01s)1649niks3-go-unit-tests>     --- PASS: TestClientErrorHandling/InvalidStorePath (0.70s)1650niks3-go-unit-tests>     --- PASS: TestClientErrorHandling/InvalidAuthToken (0.97s)1651niks3-go-unit-tests>     --- PASS: TestClientErrorHandling/ServerNotAvailable (3.25s)1652niks3-go-unit-tests> 2026/06/28 12:18:51 WARN Rate limiter enabled after throttle name=s3-test rate=51653niks3-go-unit-tests> 2026/06/28 12:18:51 WARN S3 rate limit hit operation="complete multipart upload" error="Please reduce your request rate."1654niks3-go-unit-tests> === NAME  TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle1655niks3-go-unit-tests>     throttle_test.go:226: Proxy stats: total=15, throttled=10, completeMultipart=101656niks3-go-unit-tests>     throttle_test.go:228: Rate limiter: enabled=true, rate=5.001657niks3-go-unit-tests> --- PASS: TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle (5.45s)1658niks3-go-unit-tests> PASS1659niks3-go-unit-tests> {"timestamp":"2026-06-28T12:18:52.402739043Z","level":"ERROR","fields":{"message":"Unknown connection IO error:Cancelled","peer_addr":"127.0.0.1:60528"},"target":"rustfs::server::http","filename":"rustfs/src/server/http.rs","line_number":973,"threadName":"rustfs-worker","threadId":"ThreadId(758)"}1660niks3-go-unit-tests> 2026-06-28 12:18:52.511 UTC [299] LOG:  received smart shutdown request1661niks3-go-unit-tests> 2026-06-28 12:18:52.513 UTC [299] LOG:  background worker "logical replication launcher" (PID 306) exited with exit code 11662niks3-go-unit-tests> 2026-06-28 12:18:52.520 UTC [301] LOG:  shutting down1663niks3-go-unit-tests> 2026-06-28 12:18:52.520 UTC [301] LOG:  checkpoint starting: shutdown immediate1664niks3-go-unit-tests> 2026-06-28 12:18:53.162 UTC [301] LOG:  checkpoint complete: wrote 8474 buffers (51.7%); 0 WAL file(s) added, 0 removed, 11 recycled; write=0.131 s, sync=0.505 s, total=0.643 s; sync files=13767, longest=0.005 s, average=0.001 s; distance=185258 kB, estimate=185258 kB; lsn=0/C9D7198, redo lsn=0/C9D71981665niks3-go-unit-tests> 2026-06-28 12:18:53.229 UTC [299] LOG:  database system is shut down1666niks3-go-unit-tests> Running OIDC tests...1667niks3-go-unit-tests> === RUN   TestGlobMatch1668niks3-go-unit-tests> === PAUSE TestGlobMatch1669niks3-go-unit-tests> === RUN   TestAudienceForIssuer1670niks3-go-unit-tests> === PAUSE TestAudienceForIssuer1671niks3-go-unit-tests> === RUN   TestValidateToken_ValidToken1672niks3-go-unit-tests> === PAUSE TestValidateToken_ValidToken1673niks3-go-unit-tests> === RUN   TestValidateToken_WrongAudience1674niks3-go-unit-tests> === PAUSE TestValidateToken_WrongAudience1675niks3-go-unit-tests> === RUN   TestValidateToken_Expired1676niks3-go-unit-tests> === PAUSE TestValidateToken_Expired1677niks3-go-unit-tests> === RUN   TestValidateToken_BoundClaimsMismatch1678niks3-go-unit-tests> === PAUSE TestValidateToken_BoundClaimsMismatch1679niks3-go-unit-tests> === RUN   TestValidateToken_BoundSubjectMismatch1680niks3-go-unit-tests> === PAUSE TestValidateToken_BoundSubjectMismatch1681niks3-go-unit-tests> === RUN   TestValidateToken_MultipleProviders1682niks3-go-unit-tests> === PAUSE TestValidateToken_MultipleProviders1683niks3-go-unit-tests> === RUN   TestValidateToken_NoMatchingProvider1684niks3-go-unit-tests> === PAUSE TestValidateToken_NoMatchingProvider1685niks3-go-unit-tests> === CONT  TestGlobMatch1686niks3-go-unit-tests> === CONT  TestValidateToken_BoundClaimsMismatch1687niks3-go-unit-tests> === CONT  TestValidateToken_MultipleProviders1688niks3-go-unit-tests> === CONT  TestValidateToken_BoundSubjectMismatch1689niks3-go-unit-tests> === CONT  TestValidateToken_NoMatchingProvider1690niks3-go-unit-tests> === RUN   TestGlobMatch/foo_foo1691niks3-go-unit-tests> === PAUSE TestGlobMatch/foo_foo1692niks3-go-unit-tests> === CONT  TestValidateToken_Expired1693niks3-go-unit-tests> === CONT  TestValidateToken_WrongAudience1694niks3-go-unit-tests> === CONT  TestValidateToken_ValidToken1695niks3-go-unit-tests> === CONT  TestAudienceForIssuer1696niks3-go-unit-tests> === RUN   TestGlobMatch/foo_bar1697niks3-go-unit-tests> === PAUSE TestGlobMatch/foo_bar1698niks3-go-unit-tests> --- PASS: TestAudienceForIssuer (0.00s)1699niks3-go-unit-tests> === RUN   TestGlobMatch/*_1700niks3-go-unit-tests> === PAUSE TestGlobMatch/*_1701niks3-go-unit-tests> === RUN   TestGlobMatch/*_anything1702niks3-go-unit-tests> === PAUSE TestGlobMatch/*_anything1703niks3-go-unit-tests> === RUN   TestGlobMatch/foo*_foo1704niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*_foo1705niks3-go-unit-tests> === RUN   TestGlobMatch/foo*_foobar1706niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*_foobar1707niks3-go-unit-tests> === RUN   TestGlobMatch/foo*_bar1708niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*_bar1709niks3-go-unit-tests> === RUN   TestGlobMatch/*bar_bar1710niks3-go-unit-tests> === PAUSE TestGlobMatch/*bar_bar1711niks3-go-unit-tests> === RUN   TestGlobMatch/*bar_foobar1712niks3-go-unit-tests> === PAUSE TestGlobMatch/*bar_foobar1713niks3-go-unit-tests> === RUN   TestGlobMatch/*bar_foo1714niks3-go-unit-tests> === PAUSE TestGlobMatch/*bar_foo1715niks3-go-unit-tests> === RUN   TestGlobMatch/foo*bar_foobar1716niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*bar_foobar1717niks3-go-unit-tests> === RUN   TestGlobMatch/foo*bar_foo123bar1718niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*bar_foo123bar1719niks3-go-unit-tests> === RUN   TestGlobMatch/foo*bar_foobarbaz1720niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*bar_foobarbaz1721niks3-go-unit-tests> === RUN   TestGlobMatch/*/*_foo/bar1722niks3-go-unit-tests> === PAUSE TestGlobMatch/*/*_foo/bar1723niks3-go-unit-tests> === RUN   TestGlobMatch/*/*_foo1724niks3-go-unit-tests> === PAUSE TestGlobMatch/*/*_foo1725niks3-go-unit-tests> === RUN   TestGlobMatch/refs/heads/*_refs/heads/main1726niks3-go-unit-tests> === PAUSE TestGlobMatch/refs/heads/*_refs/heads/main1727niks3-go-unit-tests> === RUN   TestGlobMatch/refs/heads/*_refs/tags/v1.01728niks3-go-unit-tests> === PAUSE TestGlobMatch/refs/heads/*_refs/tags/v1.01729niks3-go-unit-tests> === RUN   TestGlobMatch/refs/*/main_refs/heads/main1730niks3-go-unit-tests> === PAUSE TestGlobMatch/refs/*/main_refs/heads/main1731niks3-go-unit-tests> === RUN   TestGlobMatch/fo?_foo1732niks3-go-unit-tests> === PAUSE TestGlobMatch/fo?_foo1733niks3-go-unit-tests> === RUN   TestGlobMatch/fo?_fo1734niks3-go-unit-tests> === PAUSE TestGlobMatch/fo?_fo1735niks3-go-unit-tests> === RUN   TestGlobMatch/fo?_fooo1736niks3-go-unit-tests> === PAUSE TestGlobMatch/fo?_fooo1737niks3-go-unit-tests> === RUN   TestGlobMatch/?oo_foo1738niks3-go-unit-tests> === PAUSE TestGlobMatch/?oo_foo1739niks3-go-unit-tests> === RUN   TestGlobMatch/?oo_boo1740niks3-go-unit-tests> === PAUSE TestGlobMatch/?oo_boo1741niks3-go-unit-tests> === RUN   TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main1742niks3-go-unit-tests> === PAUSE TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main1743niks3-go-unit-tests> === RUN   TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main1744niks3-go-unit-tests> === PAUSE TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main1745niks3-go-unit-tests> === CONT  TestGlobMatch/foo_foo1746niks3-go-unit-tests> === CONT  TestGlobMatch/*/*_foo/bar1747niks3-go-unit-tests> === CONT  TestGlobMatch/refs/*/main_refs/heads/main1748niks3-go-unit-tests> === CONT  TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main1749niks3-go-unit-tests> === CONT  TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main1750niks3-go-unit-tests> === CONT  TestGlobMatch/?oo_boo1751niks3-go-unit-tests> === CONT  TestGlobMatch/*bar_bar1752niks3-go-unit-tests> === CONT  TestGlobMatch/?oo_foo1753niks3-go-unit-tests> === CONT  TestGlobMatch/foo*bar_foobarbaz1754niks3-go-unit-tests> === CONT  TestGlobMatch/foo*bar_foo123bar1755niks3-go-unit-tests> === CONT  TestGlobMatch/foo*bar_foobar1756niks3-go-unit-tests> === CONT  TestGlobMatch/*bar_foo1757niks3-go-unit-tests> === CONT  TestGlobMatch/*/*_foo1758niks3-go-unit-tests> === CONT  TestGlobMatch/fo?_fooo1759niks3-go-unit-tests> === CONT  TestGlobMatch/*bar_foobar1760niks3-go-unit-tests> === CONT  TestGlobMatch/foo*_foo1761niks3-go-unit-tests> === CONT  TestGlobMatch/refs/heads/*_refs/heads/main1762niks3-go-unit-tests> === CONT  TestGlobMatch/foo*_bar1763niks3-go-unit-tests> === CONT  TestGlobMatch/refs/heads/*_refs/tags/v1.01764niks3-go-unit-tests> === CONT  TestGlobMatch/*_1765niks3-go-unit-tests> === CONT  TestGlobMatch/foo*_foobar1766niks3-go-unit-tests> === CONT  TestGlobMatch/fo?_foo1767niks3-go-unit-tests> === CONT  TestGlobMatch/*_anything1768niks3-go-unit-tests> === CONT  TestGlobMatch/foo_bar1769niks3-go-unit-tests> === CONT  TestGlobMatch/fo?_fo1770niks3-go-unit-tests> --- PASS: TestGlobMatch (0.00s)1771niks3-go-unit-tests>     --- PASS: TestGlobMatch/refs/*/main_refs/heads/main (0.00s)1772niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo_foo (0.00s)1773niks3-go-unit-tests>     --- PASS: TestGlobMatch/*/*_foo/bar (0.00s)1774niks3-go-unit-tests>     --- PASS: TestGlobMatch/?oo_boo (0.00s)1775niks3-go-unit-tests>     --- PASS: TestGlobMatch/*bar_bar (0.00s)1776niks3-go-unit-tests>     --- PASS: TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main (0.00s)1777niks3-go-unit-tests>     --- PASS: TestGlobMatch/?oo_foo (0.00s)1778niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo*bar_foobarbaz (0.00s)1779niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo*bar_foobar (0.00s)1780niks3-go-unit-tests>     --- PASS: TestGlobMatch/*bar_foo (0.00s)1781niks3-go-unit-tests>     --- PASS: TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main (0.00s)1782niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo*bar_foo123bar (0.00s)1783niks3-go-unit-tests>     --- PASS: TestGlobMatch/*/*_foo (0.00s)1784niks3-go-unit-tests>     --- PASS: TestGlobMatch/fo?_fooo (0.00s)1785niks3-go-unit-tests>     --- PASS: TestGlobMatch/*bar_foobar (0.00s)1786niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo*_foo (0.00s)1787niks3-go-unit-tests>     --- PASS: TestGlobMatch/refs/heads/*_refs/heads/main (0.00s)1788niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo*_bar (0.00s)1789niks3-go-unit-tests>     --- PASS: TestGlobMatch/refs/heads/*_refs/tags/v1.0 (0.00s)1790niks3-go-unit-tests>     --- PASS: TestGlobMatch/*_ (0.00s)1791niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo*_foobar (0.00s)1792niks3-go-unit-tests>     --- PASS: TestGlobMatch/fo?_foo (0.00s)1793niks3-go-unit-tests>     --- PASS: TestGlobMatch/*_anything (0.00s)1794niks3-go-unit-tests>     --- PASS: TestGlobMatch/foo_bar (0.00s)1795niks3-go-unit-tests>     --- PASS: TestGlobMatch/fo?_fo (0.00s)1796niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=provider11797niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=test1798niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=provider11799niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=test1800niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=test1801niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=test1802niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=test1803niks3-go-unit-tests> 2026/06/28 12:18:53 INFO OIDC provider initialized name=provider21804niks3-go-unit-tests> --- PASS: TestValidateToken_BoundSubjectMismatch (0.01s)1805niks3-go-unit-tests> --- PASS: TestValidateToken_BoundClaimsMismatch (0.01s)1806niks3-go-unit-tests> --- PASS: TestValidateToken_NoMatchingProvider (0.01s)1807niks3-go-unit-tests> --- PASS: TestValidateToken_WrongAudience (0.01s)1808niks3-go-unit-tests> --- PASS: TestValidateToken_ValidToken (0.01s)1809niks3-go-unit-tests> --- PASS: TestValidateToken_MultipleProviders (0.01s)1810niks3-go-unit-tests> --- PASS: TestValidateToken_Expired (0.01s)1811niks3-go-unit-tests> PASS1812niks3-go-unit-tests> Running hook tests...1813niks3-go-unit-tests> === RUN   TestSendPathsEmpty1814niks3-go-unit-tests> === PAUSE TestSendPathsEmpty1815niks3-go-unit-tests> === RUN   TestQueueEnqueueAndFetch1816niks3-go-unit-tests> === PAUSE TestQueueEnqueueAndFetch1817niks3-go-unit-tests> === RUN   TestQueueDeduplication1818niks3-go-unit-tests> === PAUSE TestQueueDeduplication1819niks3-go-unit-tests> === RUN   TestQueueRemove1820niks3-go-unit-tests> === PAUSE TestQueueRemove1821niks3-go-unit-tests> === RUN   TestQueueFetchBatchLimit1822niks3-go-unit-tests> === PAUSE TestQueueFetchBatchLimit1823niks3-go-unit-tests> === RUN   TestQueueFetchRemoveLifecycle1824niks3-go-unit-tests> === PAUSE TestQueueFetchRemoveLifecycle1825niks3-go-unit-tests> === RUN   TestQueueConcurrentWriters1826niks3-go-unit-tests> === PAUSE TestQueueConcurrentWriters1827niks3-go-unit-tests> === RUN   TestServerClientIntegration1828niks3-go-unit-tests> === PAUSE TestServerClientIntegration1829niks3-go-unit-tests> === RUN   TestServerQueueError1830niks3-go-unit-tests> === PAUSE TestServerQueueError1831niks3-go-unit-tests> === RUN   TestGetListenerSocketActivation1832niks3-go-unit-tests>     server_test.go:210: === RUN   TestGetListenerSocketActivation1833niks3-go-unit-tests>         --- PASS: TestGetListenerSocketActivation (0.00s)1834niks3-go-unit-tests>         PASS1835niks3-go-unit-tests>         1836niks3-go-unit-tests> --- PASS: TestGetListenerSocketActivation (0.02s)1837niks3-go-unit-tests> === RUN   TestWorkerUploadsAndRemoves1838niks3-go-unit-tests> === PAUSE TestWorkerUploadsAndRemoves1839niks3-go-unit-tests> === RUN   TestWorkerSkipsGCdPaths1840niks3-go-unit-tests> === PAUSE TestWorkerSkipsGCdPaths1841niks3-go-unit-tests> === RUN   TestWorkerPrunesClosureDeps1842niks3-go-unit-tests> === PAUSE TestWorkerPrunesClosureDeps1843niks3-go-unit-tests> === CONT  TestSendPathsEmpty1844niks3-go-unit-tests> === CONT  TestQueueConcurrentWriters1845niks3-go-unit-tests> === CONT  TestQueueEnqueueAndFetch1846niks3-go-unit-tests> === CONT  TestWorkerPrunesClosureDeps1847niks3-go-unit-tests> === CONT  TestWorkerSkipsGCdPaths1848niks3-go-unit-tests> === CONT  TestWorkerUploadsAndRemoves1849niks3-go-unit-tests> === CONT  TestQueueFetchRemoveLifecycle1850niks3-go-unit-tests> === CONT  TestQueueFetchBatchLimit1851niks3-go-unit-tests> === CONT  TestQueueRemove1852niks3-go-unit-tests> === CONT  TestQueueDeduplication1853niks3-go-unit-tests> === CONT  TestServerQueueError1854niks3-go-unit-tests> === CONT  TestServerClientIntegration1855niks3-go-unit-tests> --- PASS: TestSendPathsEmpty (0.00s)1856niks3-go-unit-tests> 2026/06/28 12:18:53 ERROR Failed to queue paths error="permission denied" count=11857niks3-go-unit-tests> --- PASS: TestServerClientIntegration (0.00s)1858niks3-go-unit-tests> --- PASS: TestServerQueueError (0.00s)1859niks3-go-unit-tests> 2026/06/28 12:18:54 INFO Upload queue status pending=21860niks3-go-unit-tests> 2026/06/28 12:18:54 INFO Uploading batch count=11861niks3-go-unit-tests> --- PASS: TestQueueEnqueueAndFetch (0.02s)1862niks3-go-unit-tests> 2026/06/28 12:18:54 INFO Upload queue status pending=21863niks3-go-unit-tests> 2026/06/28 12:18:54 INFO Uploading batch count=21864niks3-go-unit-tests> 2026/06/28 12:18:54 INFO Upload queue status pending=21865niks3-go-unit-tests> 2026/06/28 12:18:54 WARN Store path no longer exists (garbage collected?), removing from queue path=/build/TestWorkerSkipsGCdPaths2336066494/002/nonexistent1866niks3-go-unit-tests> 2026/06/28 12:18:54 INFO Uploading batch count=11867niks3-go-unit-tests> --- PASS: TestQueueDeduplication (0.02s)1868niks3-go-unit-tests> --- PASS: TestQueueRemove (0.02s)1869niks3-go-unit-tests> --- PASS: TestQueueFetchBatchLimit (0.02s)1870niks3-go-unit-tests> --- PASS: TestQueueFetchRemoveLifecycle (0.02s)1871niks3-go-unit-tests> --- PASS: TestWorkerSkipsGCdPaths (0.07s)1872niks3-go-unit-tests> --- PASS: TestWorkerUploadsAndRemoves (0.07s)1873niks3-go-unit-tests> --- PASS: TestWorkerPrunesClosureDeps (0.07s)1874niks3-go-unit-tests> --- PASS: TestQueueConcurrentWriters (0.20s)1875niks3-go-unit-tests> PASS18761877post-build step Upload coverage to codecov: ok1878Skipping codecov: project=Mic92/niks3 attr=x86_64-linux.go-unit-tests