1this derivation will be built:2 /nix/store/6j1h9jdq8qjrajijw05s6dgva49fd8pc-niks3-go-unit-tests.drv3building '/nix/store/6j1h9jdq8qjrajijw05s6dgva49fd8pc-niks3-go-unit-tests.drv' on 'ssh-ng://nix@jamie'4building '/nix/store/6j1h9jdq8qjrajijw05s6dgva49fd8pc-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 TestResolveStorePath76niks3-go-unit-tests> === CONT TestShellSplitErrors77niks3-go-unit-tests> === CONT TestFileTokenMissing78niks3-go-unit-tests> === CONT TestUploadMultipart_SupersededByPeer79niks3-go-unit-tests> === RUN TestUploadMultipart_SupersededByPeer/exists80niks3-go-unit-tests> === CONT TestScriptTokenEmptyCommand81niks3-go-unit-tests> === CONT TestRateLimiterFeedback_400DoesNotCountAsSuccess82niks3-go-unit-tests> === PAUSE TestUploadMultipart_SupersededByPeer/exists83niks3-go-unit-tests> === CONT TestScriptTokenScriptFails84niks3-go-unit-tests> === CONT TestRateLimiterFeedback85niks3-go-unit-tests> === RUN TestRateLimiterFeedback/429_enables_limiter86niks3-go-unit-tests> === CONT TestSetClientTLSDoesNotMutateDefaultTransport87niks3-go-unit-tests> === CONT TestScriptTokenBadJSON88niks3-go-unit-tests> === CONT TestFileTokenReadsAndCaches89niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Rate limiter enabled after throttle name=server-test rate=590niks3-go-unit-tests> === CONT TestStaticToken91niks3-go-unit-tests> === CONT TestScriptTokenEmptyToken92niks3-go-unit-tests> === CONT TestScriptTokenCachesUntilRefresh93niks3-go-unit-tests> === CONT TestScriptTokenNoExpiryRerunsEveryCall94niks3-go-unit-tests> === CONT TestPathInfoCACompatibility95niks3-go-unit-tests> === RUN TestPathInfoCACompatibility/null_ca_field96niks3-go-unit-tests> === CONT TestSetClientTLSErrors97niks3-go-unit-tests> === CONT TestParsePathInfoJSONMultiplePaths98niks3-go-unit-tests> === RUN TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths99niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths100niks3-go-unit-tests> === CONT TestFileTokenEmpty101niks3-go-unit-tests> === CONT TestParsePathInfoJSON102niks3-go-unit-tests> === CONT TestDumpPathSingleFile103niks3-go-unit-tests> === CONT TestEncodeNixBase32104niks3-go-unit-tests> === CONT TestPathInfoHashCompatibility105niks3-go-unit-tests> === CONT TestEncodeNixBase32WithRealHash106niks3-go-unit-tests> === CONT TestGetStorePathHash107niks3-go-unit-tests> === CONT TestDumpPathWriterError108niks3-go-unit-tests> === CONT TestDumpPathMatchesNix109niks3-go-unit-tests> === CONT TestShellSplit110niks3-go-unit-tests> === CONT TestPartSizeForNAR111niks3-go-unit-tests> === CONT TestSetClientTLS112niks3-go-unit-tests> === CONT TestCaseHackSuffix113niks3-go-unit-tests> === CONT TestDoWithRetry_BodyReplayedViaGetBody114niks3-go-unit-tests> === CONT TestConvertHashToNix32115niks3-go-unit-tests> --- PASS: TestShellSplitErrors (0.00s)116niks3-go-unit-tests> === RUN TestUploadMultipart_SupersededByPeer/missing117niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/429_enables_limiter118niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/null_ca_field119niks3-go-unit-tests> === RUN TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths120niks3-go-unit-tests> --- PASS: TestScriptTokenEmptyCommand (0.00s)121niks3-go-unit-tests> --- PASS: TestFileTokenMissing (0.00s)122niks3-go-unit-tests> --- PASS: TestStaticToken (0.00s)123niks3-go-unit-tests> --- PASS: TestFileTokenReadsAndCaches (0.00s)124niks3-go-unit-tests> === PAUSE TestUploadMultipart_SupersededByPeer/missing125niks3-go-unit-tests> --- PASS: TestEncodeNixBase32WithRealHash (0.00s)126niks3-go-unit-tests> === RUN TestPathInfoCACompatibility/old_string_format_-_text127niks3-go-unit-tests> === RUN TestPartSizeForNAR/zero_stays_at_minimum128niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/zero_stays_at_minimum129niks3-go-unit-tests> === RUN TestConvertHashToNix32/SRI_format_to_Nix32130niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/SRI_format_to_Nix32131niks3-go-unit-tests> === RUN TestConvertHashToNix32/already_Nix32_format132niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/already_Nix32_format133niks3-go-unit-tests> === RUN TestConvertHashToNix32/invalid_format134niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/invalid_format135niks3-go-unit-tests> === CONT TestConvertHashToNix32/SRI_format_to_Nix32136niks3-go-unit-tests> === CONT TestConvertHashToNix32/invalid_format137niks3-go-unit-tests> === RUN TestGetStorePathHash/valid_store_path138niks3-go-unit-tests> === CONT TestConvertHashToNix32/already_Nix32_format139niks3-go-unit-tests> === RUN TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)140niks3-go-unit-tests> === RUN TestRateLimiterFeedback/503_enables_limiter141niks3-go-unit-tests> === CONT TestUploadMultipart_SupersededByPeer/exists142niks3-go-unit-tests> === RUN TestEncodeNixBase32/test_string_hash143niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths144niks3-go-unit-tests> === CONT TestUploadMultipart_SupersededByPeer/missing145niks3-go-unit-tests> --- PASS: TestShellSplit (0.00s)146niks3-go-unit-tests> === RUN TestParsePathInfoJSON/Nix_format147niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/old_string_format_-_text148niks3-go-unit-tests> --- PASS: TestResolveStorePath (0.00s)149niks3-go-unit-tests> === RUN TestPartSizeForNAR/small_stays_at_minimum150niks3-go-unit-tests> === PAUSE TestGetStorePathHash/valid_store_path151niks3-go-unit-tests> --- PASS: TestScriptTokenScriptFails (0.00s)152niks3-go-unit-tests> --- PASS: TestFileTokenEmpty (0.00s)153niks3-go-unit-tests> === CONT TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths154niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/small_stays_at_minimum155niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)156niks3-go-unit-tests> === RUN TestPathInfoCACompatibility/old_string_format_-_fixed_recursive157niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/old_string_format_-_fixed_recursive158niks3-go-unit-tests> === RUN TestPathInfoHashCompatibility/old_string_format_with_colon159niks3-go-unit-tests> === RUN TestPathInfoCACompatibility/new_structured_format_-_text160niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/new_structured_format_-_text161niks3-go-unit-tests> === CONT TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths162niks3-go-unit-tests> === RUN TestPathInfoCACompatibility/new_structured_format_-_nar_method163niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/new_structured_format_-_nar_method164niks3-go-unit-tests> === RUN TestGetStorePathHash/basename_without_hyphen_should_error165niks3-go-unit-tests> === CONT TestPathInfoCACompatibility/new_structured_format_-_nar_method166niks3-go-unit-tests> === CONT TestPathInfoCACompatibility/old_string_format_-_fixed_recursive167niks3-go-unit-tests> === CONT TestPathInfoCACompatibility/new_structured_format_-_text168niks3-go-unit-tests> === CONT TestPathInfoCACompatibility/old_string_format_-_text169niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/Nix_format170niks3-go-unit-tests> === PAUSE TestGetStorePathHash/basename_without_hyphen_should_error171niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/old_string_format_with_colon172niks3-go-unit-tests> === RUN TestParsePathInfoJSON/Lix_format173niks3-go-unit-tests> === RUN TestGetStorePathHash/hash_with_invalid_characters_should_error174niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/Lix_format175niks3-go-unit-tests> === RUN TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI176niks3-go-unit-tests> === CONT TestPathInfoCACompatibility/null_ca_field177niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI178niks3-go-unit-tests> === RUN TestParsePathInfoJSON/empty_input179niks3-go-unit-tests> === RUN TestPartSizeForNAR/80_GiB_fits_at_minimum180niks3-go-unit-tests> === PAUSE TestEncodeNixBase32/test_string_hash181niks3-go-unit-tests> --- PASS: TestParsePathInfoJSONMultiplePaths (0.00s)182niks3-go-unit-tests> --- PASS: TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths (0.00s)183niks3-go-unit-tests> --- PASS: TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths (0.00s)184niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/80_GiB_fits_at_minimum185niks3-go-unit-tests> === PAUSE TestGetStorePathHash/hash_with_invalid_characters_should_error186niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/empty_input187niks3-go-unit-tests> === RUN TestGetStorePathHash/hash_with_wrong_length_should_error188niks3-go-unit-tests> === RUN TestPartSizeForNAR/115_GiB_needs_larger_parts189niks3-go-unit-tests> === RUN TestParsePathInfoJSON/whitespace_only190niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Rate limiter enabled after throttle name=server-test rate=5191niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility (0.01s)192niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility/old_string_format_-_fixed_recursive (0.00s)193niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility/old_string_format_-_text (0.00s)194niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility/null_ca_field (0.00s)195niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility/new_structured_format_-_text (0.00s)196niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility/new_structured_format_-_nar_method (0.00s)197niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/115_GiB_needs_larger_parts198niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/whitespace_only199niks3-go-unit-tests> === RUN TestPartSizeForNAR/1_TiB200niks3-go-unit-tests> === RUN TestParsePathInfoJSON/invalid_JSON201niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/1_TiB202niks3-go-unit-tests> --- PASS: TestScriptTokenBadJSON (0.01s)203niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Request returned retryable status, retrying attempt=1 max_attempts=6 backoff=0s status=503 url=http://127.0.0.1:33961204niks3-go-unit-tests> === RUN TestPartSizeForNAR/5_TiB_S3_max_object205niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/5_TiB_S3_max_object206niks3-go-unit-tests> --- PASS: TestScriptTokenEmptyToken (0.01s)207niks3-go-unit-tests> === RUN TestPartSizeForNAR/capped_at_5_GiB208niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/capped_at_5_GiB209niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/503_enables_limiter210niks3-go-unit-tests> === PAUSE TestGetStorePathHash/hash_with_wrong_length_should_error211niks3-go-unit-tests> === RUN TestRateLimiterFeedback/200_does_not_enable_limiter212niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/invalid_JSON213niks3-go-unit-tests> === RUN TestEncodeNixBase32/empty_input214niks3-go-unit-tests> --- PASS: TestDoServerRequestAttachesToken (0.01s)215niks3-go-unit-tests> === RUN TestPathInfoHashCompatibility/new_structured_format_with_sha512216niks3-go-unit-tests> === RUN TestSetClientTLSErrors/missing_cert_file217niks3-go-unit-tests> === CONT TestPartSizeForNAR/zero_stays_at_minimum218niks3-go-unit-tests> === CONT TestPartSizeForNAR/capped_at_5_GiB219niks3-go-unit-tests> === CONT TestPartSizeForNAR/80_GiB_fits_at_minimum220niks3-go-unit-tests> === CONT TestPartSizeForNAR/5_TiB_S3_max_object221niks3-go-unit-tests> === CONT TestParsePathInfoJSON/Nix_format222niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_cert_file223niks3-go-unit-tests> === CONT TestPartSizeForNAR/1_TiB224niks3-go-unit-tests> === CONT TestPartSizeForNAR/small_stays_at_minimum225niks3-go-unit-tests> === CONT TestPartSizeForNAR/115_GiB_needs_larger_parts226niks3-go-unit-tests> === CONT TestGetStorePathHash/hash_with_invalid_characters_should_error227niks3-go-unit-tests> === CONT TestGetStorePathHash/hash_with_wrong_length_should_error228niks3-go-unit-tests> === CONT TestGetStorePathHash/valid_store_path229niks3-go-unit-tests> === CONT TestGetStorePathHash/basename_without_hyphen_should_error230niks3-go-unit-tests> --- PASS: TestPartSizeForNAR (0.01s)231niks3-go-unit-tests> --- PASS: TestPartSizeForNAR/zero_stays_at_minimum (0.00s)232niks3-go-unit-tests> --- PASS: TestPartSizeForNAR/80_GiB_fits_at_minimum (0.00s)233niks3-go-unit-tests> --- PASS: TestPartSizeForNAR/5_TiB_S3_max_object (0.00s)234niks3-go-unit-tests> --- PASS: TestPartSizeForNAR/capped_at_5_GiB (0.00s)235niks3-go-unit-tests> --- PASS: TestPartSizeForNAR/1_TiB (0.00s)236niks3-go-unit-tests> --- PASS: TestPartSizeForNAR/small_stays_at_minimum (0.00s)237niks3-go-unit-tests> --- PASS: TestPartSizeForNAR/115_GiB_needs_larger_parts (0.00s)238niks3-go-unit-tests> --- PASS: TestScriptTokenNoExpiryRerunsEveryCall (0.02s)239niks3-go-unit-tests> === CONT TestParsePathInfoJSON/invalid_JSON240niks3-go-unit-tests> === CONT TestParsePathInfoJSON/whitespace_only241niks3-go-unit-tests> === CONT TestParsePathInfoJSON/empty_input242niks3-go-unit-tests> === CONT TestParsePathInfoJSON/Lix_format243niks3-go-unit-tests> === PAUSE TestEncodeNixBase32/empty_input244niks3-go-unit-tests> === CONT TestEncodeNixBase32/test_string_hash245niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/200_does_not_enable_limiter246niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/new_structured_format_with_sha512247niks3-go-unit-tests> === CONT TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)248niks3-go-unit-tests> === CONT TestPathInfoHashCompatibility/new_structured_format_with_sha512249niks3-go-unit-tests> === RUN TestSetClientTLSErrors/missing_key_file250niks3-go-unit-tests> --- PASS: TestGetStorePathHash (0.01s)251niks3-go-unit-tests> --- PASS: TestGetStorePathHash/hash_with_invalid_characters_should_error (0.00s)252niks3-go-unit-tests> --- PASS: TestGetStorePathHash/hash_with_wrong_length_should_error (0.00s)253niks3-go-unit-tests> --- PASS: TestGetStorePathHash/valid_store_path (0.00s)254niks3-go-unit-tests> --- PASS: TestGetStorePathHash/basename_without_hyphen_should_error (0.00s)255niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_key_file256niks3-go-unit-tests> === RUN TestRateLimiterFeedback/400_does_not_enable_limiter257niks3-go-unit-tests> --- PASS: TestConvertHashToNix32 (0.00s)258niks3-go-unit-tests> --- PASS: TestConvertHashToNix32/SRI_format_to_Nix32 (0.00s)259niks3-go-unit-tests> --- PASS: TestConvertHashToNix32/invalid_format (0.00s)260niks3-go-unit-tests> --- PASS: TestConvertHashToNix32/already_Nix32_format (0.00s)261niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/400_does_not_enable_limiter262niks3-go-unit-tests> === RUN TestSetClientTLSErrors/missing_ca_file263niks3-go-unit-tests> === CONT TestPathInfoHashCompatibility/old_string_format_with_colon264niks3-go-unit-tests> === CONT TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI265niks3-go-unit-tests> === CONT TestEncodeNixBase32/empty_input266niks3-go-unit-tests> --- PASS: TestScriptTokenCachesUntilRefresh (0.02s)267niks3-go-unit-tests> === CONT TestRateLimiterFeedback/429_enables_limiter268niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON (0.01s)269niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON/Nix_format (0.00s)270niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON/invalid_JSON (0.00s)271niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON/whitespace_only (0.00s)272niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON/empty_input (0.00s)273niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON/Lix_format (0.00s)274niks3-go-unit-tests> --- PASS: TestPathInfoHashCompatibility (0.02s)275niks3-go-unit-tests> --- PASS: TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI) (0.00s)276niks3-go-unit-tests> --- PASS: TestPathInfoHashCompatibility/new_structured_format_with_sha512 (0.00s)277niks3-go-unit-tests> --- PASS: TestPathInfoHashCompatibility/old_string_format_with_colon (0.00s)278niks3-go-unit-tests> --- PASS: TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI (0.00s)279niks3-go-unit-tests> --- PASS: TestEncodeNixBase32 (0.02s)280niks3-go-unit-tests> --- PASS: TestEncodeNixBase32/test_string_hash (0.00s)281niks3-go-unit-tests> --- PASS: TestEncodeNixBase32/empty_input (0.00s)282niks3-go-unit-tests> === CONT TestRateLimiterFeedback/200_does_not_enable_limiter283niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Rate limiter backed off name=server-test rate=5284niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Request returned retryable status, retrying attempt=2 max_attempts=6 backoff=0s status=503 url=http://127.0.0.1:33961285niks3-go-unit-tests> === CONT TestRateLimiterFeedback/400_does_not_enable_limiter286niks3-go-unit-tests> === CONT TestRateLimiterFeedback/503_enables_limiter287niks3-go-unit-tests> --- PASS: TestSetClientTLSDoesNotMutateDefaultTransport (0.02s)288niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_ca_file289niks3-go-unit-tests> === RUN TestSetClientTLSErrors/invalid_ca_file290niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/invalid_ca_file291niks3-go-unit-tests> === CONT TestSetClientTLSErrors/missing_cert_file292niks3-go-unit-tests> === CONT TestSetClientTLSErrors/missing_key_file293niks3-go-unit-tests> === CONT TestSetClientTLSErrors/invalid_ca_file294niks3-go-unit-tests> --- PASS: TestDoWithRetry_BodyReplayedViaGetBody (0.02s)295niks3-go-unit-tests> === CONT TestSetClientTLSErrors/missing_ca_file296niks3-go-unit-tests> === RUN TestSetClientTLS/rejects_connection_without_client_cert297niks3-go-unit-tests> === PAUSE TestSetClientTLS/rejects_connection_without_client_cert298niks3-go-unit-tests> === RUN TestSetClientTLS/succeeds_with_client_cert_and_CA299niks3-go-unit-tests> === PAUSE TestSetClientTLS/succeeds_with_client_cert_and_CA300niks3-go-unit-tests> === RUN TestSetClientTLS/preserves_debug_logging_transport301niks3-go-unit-tests> === PAUSE TestSetClientTLS/preserves_debug_logging_transport302niks3-go-unit-tests> === CONT TestSetClientTLS/preserves_debug_logging_transport303niks3-go-unit-tests> === CONT TestSetClientTLS/succeeds_with_client_cert_and_CA304niks3-go-unit-tests> === CONT TestSetClientTLS/rejects_connection_without_client_cert305niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Rate limiter enabled after throttle name=server-test rate=5306niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Rate limiter enabled after throttle name=server-test rate=5307niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Request returned retryable status, retrying attempt=1 max_attempts=2 backoff=0s status=429 url=http://127.0.0.1:38353308niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Request returned retryable status, retrying attempt=1 max_attempts=2 backoff=0s status=503 url=http://127.0.0.1:36357309niks3-go-unit-tests> --- PASS: TestUploadMultipart_SupersededByPeer (0.00s)310niks3-go-unit-tests> --- PASS: TestUploadMultipart_SupersededByPeer/missing (0.02s)311niks3-go-unit-tests> --- PASS: TestUploadMultipart_SupersededByPeer/exists (0.02s)312niks3-go-unit-tests> --- PASS: TestSetClientTLSErrors (0.02s)313niks3-go-unit-tests> --- PASS: TestSetClientTLSErrors/missing_cert_file (0.00s)314niks3-go-unit-tests> --- PASS: TestSetClientTLSErrors/missing_key_file (0.00s)315niks3-go-unit-tests> --- PASS: TestSetClientTLSErrors/missing_ca_file (0.01s)316niks3-go-unit-tests> --- PASS: TestSetClientTLSErrors/invalid_ca_file (0.01s)317niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Rate limiter backed off name=server-test rate=5318niks3-go-unit-tests> 2026/06/28 09:21:05 WARN Rate limiter backed off name=server-test rate=5319niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback (0.02s)320niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback/200_does_not_enable_limiter (0.01s)321niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback/400_does_not_enable_limiter (0.01s)322niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback/429_enables_limiter (0.01s)323niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback/503_enables_limiter (0.01s)324niks3-go-unit-tests> 2026/06/28 09:21:05 http: TLS handshake error from 127.0.0.1:45334: remote error: tls: bad certificate325niks3-go-unit-tests> --- PASS: TestSetClientTLS (0.02s)326niks3-go-unit-tests> --- PASS: TestSetClientTLS/rejects_connection_without_client_cert (0.01s)327niks3-go-unit-tests> --- PASS: TestSetClientTLS/succeeds_with_client_cert_and_CA (0.01s)328niks3-go-unit-tests> --- PASS: TestSetClientTLS/preserves_debug_logging_transport (0.01s)329niks3-go-unit-tests> --- PASS: TestDumpPathSingleFile (0.04s)330niks3-go-unit-tests> --- PASS: TestDumpPathWriterError (0.06s)331niks3-go-unit-tests> --- PASS: TestCaseHackSuffix (0.07s)332niks3-go-unit-tests> --- PASS: TestDumpPathMatchesNix (0.10s)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/postgres1188155306/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/postgres1188155306/data -l logfile start362niks3-go-unit-tests> 363niks3-go-unit-tests> /build/postgres1188155306:5432 - no response364niks3-go-unit-tests> 2026-06-28 09:21:07.448 UTC [311] 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 09:21:07.449 UTC [311] LOG: listening on Unix socket "/build/postgres1188155306/.s.PGSQL.5432"366niks3-go-unit-tests> 2026-06-28 09:21:07.452 UTC [315] LOG: database system was shut down at 2026-06-28 09:21:07 UTC367niks3-go-unit-tests> 2026-06-28 09:21:07.456 UTC [311] LOG: database system is ready to accept connections368niks3-go-unit-tests> /build/postgres1188155306:5432 - accepting connections369niks3-go-unit-tests> RustFS API: http://127.0.0.1:41691 http://127.0.0.1:41691370niks3-go-unit-tests> RustFS Start Time: 2026-06-28 09:21:07371niks3-go-unit-tests> Console WebUI Start Time: 2026-06-28 09:21:07372niks3-go-unit-tests> Console WebUI available at: http://127.0.0.1:38141/rustfs/console/index.html373niks3-go-unit-tests> Console WebUI (localhost): http://127.0.0.1:38141/rustfs/console/index.html374niks3-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 TestGCTaskStore_StartNew401niks3-go-unit-tests> === PAUSE TestGCTaskStore_StartNew402niks3-go-unit-tests> === RUN TestGCTaskStore_DeduplicateSameParams403niks3-go-unit-tests> === PAUSE TestGCTaskStore_DeduplicateSameParams404niks3-go-unit-tests> === RUN TestGCTaskStore_ConflictDifferentParams405niks3-go-unit-tests> === PAUSE TestGCTaskStore_ConflictDifferentParams406niks3-go-unit-tests> === RUN TestGCTaskStore_GetEmpty407niks3-go-unit-tests> === PAUSE TestGCTaskStore_GetEmpty408niks3-go-unit-tests> === RUN TestGCTaskStore_GetReturnsLatest409niks3-go-unit-tests> === PAUSE TestGCTaskStore_GetReturnsLatest410niks3-go-unit-tests> === RUN TestGCTaskStore_CompletedAllowsNewTask411niks3-go-unit-tests> === PAUSE TestGCTaskStore_CompletedAllowsNewTask412niks3-go-unit-tests> === RUN TestGCTaskStore_PhaseUpdates413niks3-go-unit-tests> === PAUSE TestGCTaskStore_PhaseUpdates414niks3-go-unit-tests> === RUN TestGCTaskStore_Fail415niks3-go-unit-tests> === PAUSE TestGCTaskStore_Fail416niks3-go-unit-tests> === RUN TestService_healthCheckHandler417niks3-go-unit-tests> === PAUSE TestService_healthCheckHandler418niks3-go-unit-tests> === RUN TestGenerateLandingPage419niks3-go-unit-tests> === PAUSE TestGenerateLandingPage420niks3-go-unit-tests> === RUN TestNARDeduplicationMetadataUploadBug421niks3-go-unit-tests> === PAUSE TestNARDeduplicationMetadataUploadBug422niks3-go-unit-tests> === RUN TestService_NativeMTLS423niks3-go-unit-tests> === PAUSE TestService_NativeMTLS424niks3-go-unit-tests> === RUN TestServerTLSConfig425niks3-go-unit-tests> === PAUSE TestServerTLSConfig426niks3-go-unit-tests> === RUN TestMultipartCleanup427niks3-go-unit-tests> === PAUSE TestMultipartCleanup428niks3-go-unit-tests> === RUN TestOrphanedObjectsGC429niks3-go-unit-tests> === PAUSE TestOrphanedObjectsGC430niks3-go-unit-tests> === RUN TestOrphanedObjectsGCStressTest431niks3-go-unit-tests> === PAUSE TestOrphanedObjectsGCStressTest432niks3-go-unit-tests> === RUN TestResurrectedObjectNotDeleted433niks3-go-unit-tests> === PAUSE TestResurrectedObjectNotDeleted434niks3-go-unit-tests> === RUN TestParseSingleRange435niks3-go-unit-tests> === PAUSE TestParseSingleRange436niks3-go-unit-tests> === RUN TestIsValidCachePath437niks3-go-unit-tests> === PAUSE TestIsValidCachePath438niks3-go-unit-tests> === RUN TestReadProxyNarinfo439niks3-go-unit-tests> === PAUSE TestReadProxyNarinfo440niks3-go-unit-tests> === RUN TestReadProxyNarinfoAlreadyDecompressed441niks3-go-unit-tests> === PAUSE TestReadProxyNarinfoAlreadyDecompressed442niks3-go-unit-tests> === RUN TestReadProxyNarStreaming443niks3-go-unit-tests> === PAUSE TestReadProxyNarStreaming444niks3-go-unit-tests> === RUN TestReadProxy404445niks3-go-unit-tests> === PAUSE TestReadProxy404446niks3-go-unit-tests> === RUN TestReadProxyInvalidPath447niks3-go-unit-tests> === PAUSE TestReadProxyInvalidPath448niks3-go-unit-tests> === RUN TestReadProxyHead449niks3-go-unit-tests> === PAUSE TestReadProxyHead450niks3-go-unit-tests> === RUN TestReadProxyConditionalGet451niks3-go-unit-tests> === PAUSE TestReadProxyConditionalGet452niks3-go-unit-tests> === RUN TestReadProxyRootRedirectsToIndexHTML453niks3-go-unit-tests> === PAUSE TestReadProxyRootRedirectsToIndexHTML454niks3-go-unit-tests> === RUN TestReadProxyDisabled455niks3-go-unit-tests> === PAUSE TestReadProxyDisabled456niks3-go-unit-tests> === RUN TestReadProxyRangeRequest457niks3-go-unit-tests> === PAUSE TestReadProxyRangeRequest458niks3-go-unit-tests> === RUN TestRedundantMultipartUpload459niks3-go-unit-tests> === PAUSE TestRedundantMultipartUpload460niks3-go-unit-tests> === RUN TestService_Rustfstest461niks3-go-unit-tests> === PAUSE TestService_Rustfstest462niks3-go-unit-tests> === RUN TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle463niks3-go-unit-tests> === PAUSE TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle464niks3-go-unit-tests> === RUN TestProxyWriteTimeout465niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout466niks3-go-unit-tests> === RUN TestIsValidUploadKey467niks3-go-unit-tests> === PAUSE TestIsValidUploadKey468niks3-go-unit-tests> === RUN TestUploadHandlersRejectInvalidKeys469niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys470niks3-go-unit-tests> === RUN TestUploadHandlersRejectOversizedBody471niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody472niks3-go-unit-tests> === RUN TestService_cleanupPendingClosuresHandler473niks3-go-unit-tests> === PAUSE TestService_cleanupPendingClosuresHandler474niks3-go-unit-tests> === RUN TestService_createPendingClosureHandler475niks3-go-unit-tests> === PAUSE TestService_createPendingClosureHandler476niks3-go-unit-tests> === RUN TestService_verifyS3Integrity477niks3-go-unit-tests> === PAUSE TestService_verifyS3Integrity478niks3-go-unit-tests> === RUN TestCompleteMultipartUnregistered479niks3-go-unit-tests> === PAUSE TestCompleteMultipartUnregistered480niks3-go-unit-tests> === RUN TestCreatePendingClosure_SmallNARUsesSimplePUT481niks3-go-unit-tests> === PAUSE TestCreatePendingClosure_SmallNARUsesSimplePUT482niks3-go-unit-tests> === CONT TestService_AuthMiddleware483niks3-go-unit-tests> === CONT TestGCTaskStore_DeduplicateSameParams484niks3-go-unit-tests> === CONT TestGCBugBareHashReferences485niks3-go-unit-tests> === CONT TestClientWithDependencies486niks3-go-unit-tests> === CONT TestService_NativeMTLS487niks3-go-unit-tests> --- PASS: TestGCTaskStore_DeduplicateSameParams (0.00s)488niks3-go-unit-tests> === CONT TestReadProxyConditionalGet489niks3-go-unit-tests> === CONT TestCreatePendingClosure_SmallNARUsesSimplePUT490niks3-go-unit-tests> === CONT TestGCTaskStore_CompletedAllowsNewTask491niks3-go-unit-tests> --- PASS: TestGCTaskStore_CompletedAllowsNewTask (0.00s)492niks3-go-unit-tests> === CONT TestService_verifyS3Integrity493niks3-go-unit-tests> === CONT TestService_createPendingClosureHandler494niks3-go-unit-tests> === CONT TestService_cleanupPendingClosuresHandler495niks3-go-unit-tests> === CONT TestUploadHandlersRejectOversizedBody496niks3-go-unit-tests> === CONT TestReadProxyHead497niks3-go-unit-tests> === CONT TestReadProxyInvalidPath498niks3-go-unit-tests> === CONT TestReadProxy404499niks3-go-unit-tests> === CONT TestReadProxyNarStreaming500niks3-go-unit-tests> === CONT TestReadProxyNarinfoAlreadyDecompressed501niks3-go-unit-tests> === CONT TestReadProxyNarinfo502niks3-go-unit-tests> === CONT TestIsValidCachePath503niks3-go-unit-tests> === CONT TestParseSingleRange504niks3-go-unit-tests> === CONT TestResurrectedObjectNotDeleted505niks3-go-unit-tests> === RUN TestParseSingleRange/none506niks3-go-unit-tests> === CONT TestOrphanedObjectsGCStressTest507niks3-go-unit-tests> === CONT TestService_Rustfstest508niks3-go-unit-tests> === CONT TestUploadHandlersRejectInvalidKeys509niks3-go-unit-tests> === RUN TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info510niks3-go-unit-tests> === CONT TestIsValidUploadKey511niks3-go-unit-tests> === CONT TestProxyWriteTimeout512niks3-go-unit-tests> === RUN TestProxyWriteTimeout/narinfo513niks3-go-unit-tests> === CONT TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle514niks3-go-unit-tests> === CONT TestClientErrorHandling515niks3-go-unit-tests> === CONT TestGCTaskStore_StartNew516niks3-go-unit-tests> === CONT TestRedundantMultipartUpload517niks3-go-unit-tests> === CONT TestReadProxyRangeRequest518niks3-go-unit-tests> === CONT TestReadProxyDisabled519niks3-go-unit-tests> === CONT TestReadProxyRootRedirectsToIndexHTML520niks3-go-unit-tests> === CONT TestService_healthCheckHandler521niks3-go-unit-tests> === CONT TestMultipartCleanup522niks3-go-unit-tests> === CONT TestNARDeduplicationMetadataUploadBug523niks3-go-unit-tests> === CONT TestGenerateLandingPage524niks3-go-unit-tests> === CONT TestService_AuthMiddleware_OIDC525niks3-go-unit-tests> === CONT TestClientCADerivations526niks3-go-unit-tests> === CONT TestCacheConfigHandler527niks3-go-unit-tests> === CONT TestServerTLSConfig528niks3-go-unit-tests> === CONT TestClientMultipleUploads529niks3-go-unit-tests> === CONT TestClientIntegration530niks3-go-unit-tests> === CONT TestGCTaskStore_Fail531niks3-go-unit-tests> === CONT TestGCTaskStore_GetEmpty532niks3-go-unit-tests> === CONT TestGCTaskStore_GetReturnsLatest533niks3-go-unit-tests> === CONT TestService_AuthMiddleware_MTLSBoundSubjects534niks3-go-unit-tests> === CONT TestService_ReadAuthMiddleware535niks3-go-unit-tests> === CONT TestGCTaskStore_ConflictDifferentParams536niks3-go-unit-tests> === CONT TestGCTaskStore_PhaseUpdates537niks3-go-unit-tests> === CONT TestOrphanedObjectsGC538niks3-go-unit-tests> === CONT TestService_AuthMiddleware_MTLSProxyHeader539niks3-go-unit-tests> === CONT TestPinProtectsFromGC540niks3-go-unit-tests> === CONT TestCompleteMultipartUnregistered541niks3-go-unit-tests> === RUN TestIsValidCachePath/narinfo542niks3-go-unit-tests> === PAUSE TestParseSingleRange/none543niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info544niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/narinfo545niks3-go-unit-tests> --- PASS: TestGCTaskStore_StartNew (0.00s)546niks3-go-unit-tests> === RUN TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal547niks3-go-unit-tests> === RUN TestClientErrorHandling/InvalidStorePath548niks3-go-unit-tests> === RUN TestServerTLSConfig/no_client_CA549niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal550niks3-go-unit-tests> === RUN TestProxyWriteTimeout/1_GiB_nar551niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/1_GiB_nar552niks3-go-unit-tests> --- PASS: TestGCTaskStore_ConflictDifferentParams (0.00s)553niks3-go-unit-tests> --- PASS: TestGCTaskStore_GetEmpty (0.00s)554niks3-go-unit-tests> === PAUSE TestClientErrorHandling/InvalidStorePath555niks3-go-unit-tests> === RUN TestCacheConfigHandler/full_config,_no_issuer556niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/full_config,_no_issuer557niks3-go-unit-tests> === RUN TestCacheConfigHandler/no_cache_url_configured558niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/no_cache_url_configured559niks3-go-unit-tests> === RUN TestCacheConfigHandler/no_signing_keys560niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/no_signing_keys561niks3-go-unit-tests> === RUN TestClientErrorHandling/InvalidAuthToken562niks3-go-unit-tests> === RUN TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator563niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator564niks3-go-unit-tests> === PAUSE TestClientErrorHandling/InvalidAuthToken565niks3-go-unit-tests> === CONT TestCacheConfigHandler/full_config,_no_issuer566niks3-go-unit-tests> === RUN TestClientErrorHandling/ServerNotAvailable567niks3-go-unit-tests> === PAUSE TestClientErrorHandling/ServerNotAvailable568niks3-go-unit-tests> === CONT TestClientErrorHandling/InvalidStorePath569niks3-go-unit-tests> === CONT TestClientErrorHandling/ServerNotAvailable570niks3-go-unit-tests> === RUN TestParseSingleRange/unknown_unit571niks3-go-unit-tests> === PAUSE TestParseSingleRange/unknown_unit572niks3-go-unit-tests> === RUN TestParseSingleRange/multi-range_ignored573niks3-go-unit-tests> === PAUSE TestParseSingleRange/multi-range_ignored574niks3-go-unit-tests> === RUN TestParseSingleRange/malformed_no_dash575niks3-go-unit-tests> === PAUSE TestParseSingleRange/malformed_no_dash576niks3-go-unit-tests> === RUN TestParseSingleRange/malformed_both_empty577niks3-go-unit-tests> === PAUSE TestParseSingleRange/malformed_both_empty578niks3-go-unit-tests> === RUN TestParseSingleRange/malformed_end_before_start579niks3-go-unit-tests> === PAUSE TestParseSingleRange/malformed_end_before_start580niks3-go-unit-tests> === RUN TestParseSingleRange/closed581niks3-go-unit-tests> === PAUSE TestParseSingleRange/closed582niks3-go-unit-tests> === RUN TestParseSingleRange/open-ended583niks3-go-unit-tests> === PAUSE TestParseSingleRange/open-ended584niks3-go-unit-tests> --- PASS: TestGCTaskStore_Fail (0.00s)585niks3-go-unit-tests> --- PASS: TestGCTaskStore_PhaseUpdates (0.00s)586niks3-go-unit-tests> === CONT TestClientErrorHandling/InvalidAuthToken587niks3-go-unit-tests> === RUN TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key588niks3-go-unit-tests> === RUN TestProxyWriteTimeout/10_GiB_nar589niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key590niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/10_GiB_nar591niks3-go-unit-tests> === PAUSE TestServerTLSConfig/no_client_CA592niks3-go-unit-tests> === CONT TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator593niks3-go-unit-tests> === RUN TestServerTLSConfig/missing_CA_file594niks3-go-unit-tests> === PAUSE TestServerTLSConfig/missing_CA_file595niks3-go-unit-tests> === CONT TestCacheConfigHandler/no_signing_keys596niks3-go-unit-tests> === CONT TestCacheConfigHandler/no_cache_url_configured597niks3-go-unit-tests> === RUN TestParseSingleRange/end_clamped_to_size598niks3-go-unit-tests> === PAUSE TestParseSingleRange/end_clamped_to_size599niks3-go-unit-tests> === RUN TestParseSingleRange/suffix600niks3-go-unit-tests> === PAUSE TestParseSingleRange/suffix601niks3-go-unit-tests> === PAUSE TestIsValidCachePath/narinfo602niks3-go-unit-tests> --- PASS: TestGCTaskStore_GetReturnsLatest (0.00s)603niks3-go-unit-tests> === RUN TestIsValidUploadKey/narinfo604niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/narinfo605niks3-go-unit-tests> === RUN TestProxyWriteTimeout/unknown_size606niks3-go-unit-tests> === RUN TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key607niks3-go-unit-tests> === RUN TestParseSingleRange/suffix_exceeds_size608niks3-go-unit-tests> === RUN TestServerTLSConfig/not_a_PEM_file609niks3-go-unit-tests> === PAUSE TestServerTLSConfig/not_a_PEM_file610niks3-go-unit-tests> === PAUSE TestParseSingleRange/suffix_exceeds_size611niks3-go-unit-tests> === CONT TestServerTLSConfig/no_client_CA612niks3-go-unit-tests> === RUN TestIsValidCachePath/narinfo_all_nix_base32_chars613niks3-go-unit-tests> === PAUSE TestIsValidCachePath/narinfo_all_nix_base32_chars614niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key615niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/unknown_size616niks3-go-unit-tests> === CONT TestServerTLSConfig/not_a_PEM_file617niks3-go-unit-tests> === CONT TestProxyWriteTimeout/1_GiB_nar618niks3-go-unit-tests> === CONT TestServerTLSConfig/missing_CA_file619niks3-go-unit-tests> === RUN TestIsValidUploadKey/nar_zst620niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_zst621niks3-go-unit-tests> === RUN TestIsValidCachePath/nar_zst622niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_zst623niks3-go-unit-tests> === RUN TestParseSingleRange/single_byte624niks3-go-unit-tests> === RUN TestIsValidCachePath/nar_xz625niks3-go-unit-tests> === CONT TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key626niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_xz627niks3-go-unit-tests> === RUN TestIsValidCachePath/nar_bz2628niks3-go-unit-tests> --- PASS: TestCacheConfigHandler (0.00s)629niks3-go-unit-tests> --- PASS: TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator (0.00s)630niks3-go-unit-tests> --- PASS: TestCacheConfigHandler/no_signing_keys (0.00s)631niks3-go-unit-tests> --- PASS: TestCacheConfigHandler/no_cache_url_configured (0.00s)632niks3-go-unit-tests> --- PASS: TestCacheConfigHandler/full_config,_no_issuer (0.00s)633niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_bz2634niks3-go-unit-tests> === CONT TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal635niks3-go-unit-tests> === RUN TestIsValidCachePath/nar_uncompressed636niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nar_uncompressed637niks3-go-unit-tests> === CONT TestProxyWriteTimeout/narinfo638niks3-go-unit-tests> === CONT TestProxyWriteTimeout/unknown_size639niks3-go-unit-tests> === CONT TestProxyWriteTimeout/10_GiB_nar640niks3-go-unit-tests> === CONT TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info641niks3-go-unit-tests> --- PASS: TestProxyWriteTimeout (0.00s)642niks3-go-unit-tests> --- PASS: TestProxyWriteTimeout/1_GiB_nar (0.00s)643niks3-go-unit-tests> --- PASS: TestProxyWriteTimeout/narinfo (0.00s)644niks3-go-unit-tests> --- PASS: TestProxyWriteTimeout/unknown_size (0.00s)645niks3-go-unit-tests> --- PASS: TestProxyWriteTimeout/10_GiB_nar (0.00s)646niks3-go-unit-tests> === RUN TestIsValidUploadKey/nar_xz647niks3-go-unit-tests> 2026/06/28 09:21:07 INFO Received request for more parts method=POST path=/648niks3-go-unit-tests> === PAUSE TestParseSingleRange/single_byte649niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_xz650niks3-go-unit-tests> === RUN TestIsValidUploadKey/nar_plain651niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_plain652niks3-go-unit-tests> === RUN TestParseSingleRange/start_past_EOF653niks3-go-unit-tests> === RUN TestIsValidUploadKey/listing654niks3-go-unit-tests> 2026/06/28 09:21:07 INFO Received uploads request method=POST path=/655niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/listing656niks3-go-unit-tests> === RUN TestIsValidCachePath/ls657niks3-go-unit-tests> === RUN TestIsValidUploadKey/build_log658niks3-go-unit-tests> === CONT TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key659niks3-go-unit-tests> === PAUSE TestIsValidCachePath/ls660niks3-go-unit-tests> 2026/06/28 09:21:07 INFO Received uploads request method=POST path=/661niks3-go-unit-tests> === PAUSE TestParseSingleRange/start_past_EOF662niks3-go-unit-tests> === RUN TestIsValidCachePath/log663niks3-go-unit-tests> === PAUSE TestIsValidCachePath/log664niks3-go-unit-tests> === RUN TestParseSingleRange/start_far_past_EOF665niks3-go-unit-tests> 2026/06/28 09:21:07 INFO Received complete multipart upload request method=POST path=/666niks3-go-unit-tests> === RUN TestIsValidCachePath/realisation667niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log668niks3-go-unit-tests> === PAUSE TestIsValidCachePath/realisation669niks3-go-unit-tests> === RUN TestIsValidUploadKey/build_log_home-manager_file670niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_home-manager_file671niks3-go-unit-tests> === RUN TestIsValidCachePath/nix-cache-info672niks3-go-unit-tests> === PAUSE TestParseSingleRange/start_far_past_EOF673niks3-go-unit-tests> === RUN TestIsValidUploadKey/build_log_plus_in_name674niks3-go-unit-tests> === CONT TestParseSingleRange/start_past_EOF675niks3-go-unit-tests> === CONT TestParseSingleRange/unknown_unit676niks3-go-unit-tests> === CONT TestParseSingleRange/end_clamped_to_size677niks3-go-unit-tests> === CONT TestParseSingleRange/closed678niks3-go-unit-tests> === PAUSE TestIsValidCachePath/nix-cache-info679niks3-go-unit-tests> === CONT TestParseSingleRange/none680niks3-go-unit-tests> === RUN TestIsValidCachePath/index.html681niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectInvalidKeys (0.00s)682niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key (0.00s)683niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key (0.00s)684niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info (0.00s)685niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal (0.00s)686niks3-go-unit-tests> === CONT TestParseSingleRange/start_far_past_EOF687niks3-go-unit-tests> --- PASS: TestServerTLSConfig (0.00s)688niks3-go-unit-tests> --- PASS: TestServerTLSConfig/no_client_CA (0.00s)689niks3-go-unit-tests> --- PASS: TestServerTLSConfig/missing_CA_file (0.00s)690niks3-go-unit-tests> --- PASS: TestServerTLSConfig/not_a_PEM_file (0.00s)691niks3-go-unit-tests> === CONT TestParseSingleRange/suffix692niks3-go-unit-tests> === CONT TestParseSingleRange/malformed_both_empty693niks3-go-unit-tests> === CONT TestParseSingleRange/malformed_no_dash694niks3-go-unit-tests> === CONT TestParseSingleRange/multi-range_ignored695niks3-go-unit-tests> === CONT TestParseSingleRange/single_byte696niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_plus_in_name697niks3-go-unit-tests> === CONT TestParseSingleRange/open-ended698niks3-go-unit-tests> === RUN TestIsValidUploadKey/build_log_question_mark699niks3-go-unit-tests> === CONT TestParseSingleRange/suffix_exceeds_size700niks3-go-unit-tests> === PAUSE TestIsValidCachePath/index.html701niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_question_mark702niks3-go-unit-tests> === RUN TestIsValidCachePath/traversal_parent703niks3-go-unit-tests> === PAUSE TestIsValidCachePath/traversal_parent704niks3-go-unit-tests> === RUN TestIsValidUploadKey/build_log_equals705niks3-go-unit-tests> === RUN TestIsValidCachePath/traversal_in_middle706niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_equals707niks3-go-unit-tests> === PAUSE TestIsValidCachePath/traversal_in_middle708niks3-go-unit-tests> === CONT TestParseSingleRange/malformed_end_before_start709niks3-go-unit-tests> === RUN TestIsValidCachePath/invalid_char_e710niks3-go-unit-tests> === PAUSE TestIsValidCachePath/invalid_char_e711niks3-go-unit-tests> === RUN TestIsValidCachePath/invalid_char_u712niks3-go-unit-tests> === PAUSE TestIsValidCachePath/invalid_char_u713niks3-go-unit-tests> === RUN TestIsValidCachePath/random_path714niks3-go-unit-tests> === PAUSE TestIsValidCachePath/random_path715niks3-go-unit-tests> --- PASS: TestParseSingleRange (0.00s)716niks3-go-unit-tests> --- PASS: TestParseSingleRange/end_clamped_to_size (0.00s)717niks3-go-unit-tests> --- PASS: TestParseSingleRange/closed (0.00s)718niks3-go-unit-tests> --- PASS: TestParseSingleRange/unknown_unit (0.00s)719niks3-go-unit-tests> --- PASS: TestParseSingleRange/start_past_EOF (0.00s)720niks3-go-unit-tests> --- PASS: TestParseSingleRange/none (0.00s)721niks3-go-unit-tests> --- PASS: TestParseSingleRange/start_far_past_EOF (0.00s)722niks3-go-unit-tests> --- PASS: TestParseSingleRange/suffix (0.00s)723niks3-go-unit-tests> --- PASS: TestParseSingleRange/malformed_both_empty (0.00s)724niks3-go-unit-tests> --- PASS: TestParseSingleRange/malformed_no_dash (0.00s)725niks3-go-unit-tests> --- PASS: TestParseSingleRange/multi-range_ignored (0.00s)726niks3-go-unit-tests> --- PASS: TestParseSingleRange/single_byte (0.00s)727niks3-go-unit-tests> --- PASS: TestParseSingleRange/open-ended (0.00s)728niks3-go-unit-tests> --- PASS: TestParseSingleRange/suffix_exceeds_size (0.00s)729niks3-go-unit-tests> --- PASS: TestParseSingleRange/malformed_end_before_start (0.00s)730niks3-go-unit-tests> === RUN TestIsValidUploadKey/realisation731niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/realisation732niks3-go-unit-tests> === RUN TestIsValidUploadKey/realisation_plus_in_output733niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/realisation_plus_in_output734niks3-go-unit-tests> === RUN TestIsValidCachePath/empty735niks3-go-unit-tests> === RUN TestIsValidUploadKey/nix-cache-info736niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nix-cache-info737niks3-go-unit-tests> === PAUSE TestIsValidCachePath/empty738niks3-go-unit-tests> === RUN TestIsValidUploadKey/index.html739niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/index.html740niks3-go-unit-tests> === RUN TestIsValidCachePath/leading_slash741niks3-go-unit-tests> === RUN TestIsValidUploadKey/narinfo_key,_nar_type742niks3-go-unit-tests> === PAUSE TestIsValidCachePath/leading_slash743niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/narinfo_key,_nar_type744niks3-go-unit-tests> === RUN TestIsValidCachePath/wrong_extension745niks3-go-unit-tests> === RUN TestIsValidUploadKey/nar_key,_narinfo_type746niks3-go-unit-tests> === PAUSE TestIsValidCachePath/wrong_extension747niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_key,_narinfo_type748niks3-go-unit-tests> === RUN TestIsValidCachePath/short_hash749niks3-go-unit-tests> === PAUSE TestIsValidCachePath/short_hash750niks3-go-unit-tests> === RUN TestIsValidUploadKey/listing_key,_narinfo_type751niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/listing_key,_narinfo_type752niks3-go-unit-tests> === CONT TestIsValidCachePath/invalid_char_e753niks3-go-unit-tests> === RUN TestIsValidUploadKey/traversal754niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/traversal755niks3-go-unit-tests> === CONT TestIsValidCachePath/log756niks3-go-unit-tests> === CONT TestIsValidCachePath/nar_bz2757niks3-go-unit-tests> === CONT TestIsValidCachePath/ls758niks3-go-unit-tests> === CONT TestIsValidCachePath/nar_zst759niks3-go-unit-tests> === CONT TestIsValidCachePath/nar_xz760niks3-go-unit-tests> === CONT TestIsValidCachePath/nar_uncompressed761niks3-go-unit-tests> === CONT TestIsValidCachePath/traversal_parent762niks3-go-unit-tests> === CONT TestIsValidCachePath/short_hash763niks3-go-unit-tests> === CONT TestIsValidCachePath/nix-cache-info764niks3-go-unit-tests> === CONT TestIsValidCachePath/index.html765niks3-go-unit-tests> === RUN TestIsValidUploadKey/traversal_nar766niks3-go-unit-tests> === CONT TestIsValidCachePath/leading_slash767niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/traversal_nar768niks3-go-unit-tests> === CONT TestIsValidCachePath/wrong_extension769niks3-go-unit-tests> === RUN TestIsValidUploadKey/absolute770niks3-go-unit-tests> === CONT TestIsValidCachePath/random_path771niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/absolute772niks3-go-unit-tests> === RUN TestIsValidUploadKey/empty_key773niks3-go-unit-tests> === CONT TestIsValidCachePath/invalid_char_u774niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/empty_key775niks3-go-unit-tests> === RUN TestIsValidUploadKey/unknown_type776niks3-go-unit-tests> === CONT TestIsValidCachePath/narinfo777niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/unknown_type778niks3-go-unit-tests> === CONT TestIsValidCachePath/traversal_in_middle779niks3-go-unit-tests> === CONT TestIsValidCachePath/narinfo_all_nix_base32_chars780niks3-go-unit-tests> === CONT TestIsValidUploadKey/empty_key781niks3-go-unit-tests> === CONT TestIsValidUploadKey/traversal782niks3-go-unit-tests> === CONT TestIsValidCachePath/realisation783niks3-go-unit-tests> === CONT TestIsValidUploadKey/unknown_type784niks3-go-unit-tests> === CONT TestIsValidUploadKey/narinfo_key,_nar_type785niks3-go-unit-tests> === CONT TestIsValidUploadKey/build_log_plus_in_name786niks3-go-unit-tests> === CONT TestIsValidUploadKey/build_log787niks3-go-unit-tests> === CONT TestIsValidUploadKey/nix-cache-info788niks3-go-unit-tests> === CONT TestIsValidUploadKey/listing_key,_narinfo_type789niks3-go-unit-tests> === CONT TestIsValidUploadKey/realisation_plus_in_output790niks3-go-unit-tests> === CONT TestIsValidCachePath/empty791niks3-go-unit-tests> === CONT TestIsValidUploadKey/build_log_question_mark792niks3-go-unit-tests> === CONT TestIsValidUploadKey/build_log_equals793niks3-go-unit-tests> === CONT TestIsValidUploadKey/realisation794niks3-go-unit-tests> === CONT TestIsValidUploadKey/narinfo795niks3-go-unit-tests> === CONT TestIsValidUploadKey/nar_xz796niks3-go-unit-tests> === CONT TestIsValidUploadKey/listing797niks3-go-unit-tests> === CONT TestIsValidUploadKey/absolute798niks3-go-unit-tests> === CONT TestIsValidUploadKey/traversal_nar799niks3-go-unit-tests> === CONT TestIsValidUploadKey/nar_key,_narinfo_type800niks3-go-unit-tests> === CONT TestIsValidUploadKey/build_log_home-manager_file801niks3-go-unit-tests> === CONT TestIsValidUploadKey/index.html802niks3-go-unit-tests> --- PASS: TestIsValidCachePath (0.01s)803niks3-go-unit-tests> --- PASS: TestIsValidCachePath/ls (0.00s)804niks3-go-unit-tests> --- PASS: TestIsValidCachePath/nar_xz (0.00s)805niks3-go-unit-tests> --- PASS: TestIsValidCachePath/nar_bz2 (0.00s)806niks3-go-unit-tests> --- PASS: TestIsValidCachePath/nar_uncompressed (0.00s)807niks3-go-unit-tests> --- PASS: TestIsValidCachePath/nar_zst (0.00s)808niks3-go-unit-tests> --- PASS: TestIsValidCachePath/traversal_parent (0.00s)809niks3-go-unit-tests> --- PASS: TestIsValidCachePath/nix-cache-info (0.00s)810niks3-go-unit-tests> --- PASS: TestIsValidCachePath/index.html (0.00s)811niks3-go-unit-tests> --- PASS: TestIsValidCachePath/log (0.00s)812niks3-go-unit-tests> --- PASS: TestIsValidCachePath/short_hash (0.00s)813niks3-go-unit-tests> --- PASS: TestIsValidCachePath/leading_slash (0.00s)814niks3-go-unit-tests> --- PASS: TestIsValidCachePath/invalid_char_e (0.00s)815niks3-go-unit-tests> --- PASS: TestIsValidCachePath/wrong_extension (0.00s)816niks3-go-unit-tests> --- PASS: TestIsValidCachePath/random_path (0.00s)817niks3-go-unit-tests> --- PASS: TestIsValidCachePath/invalid_char_u (0.00s)818niks3-go-unit-tests> --- PASS: TestIsValidCachePath/narinfo (0.00s)819niks3-go-unit-tests> --- PASS: TestIsValidCachePath/traversal_in_middle (0.00s)820niks3-go-unit-tests> --- PASS: TestIsValidCachePath/narinfo_all_nix_base32_chars (0.00s)821niks3-go-unit-tests> --- PASS: TestIsValidCachePath/realisation (0.00s)822niks3-go-unit-tests> --- PASS: TestIsValidCachePath/empty (0.00s)823niks3-go-unit-tests> === CONT TestIsValidUploadKey/nar_plain824niks3-go-unit-tests> === CONT TestIsValidUploadKey/nar_zst825niks3-go-unit-tests> --- PASS: TestGenerateLandingPage (0.00s)826niks3-go-unit-tests> --- PASS: TestIsValidUploadKey (0.00s)827niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/empty_key (0.00s)828niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/traversal (0.00s)829niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/unknown_type (0.00s)830niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/narinfo_key,_nar_type (0.00s)831niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/build_log_plus_in_name (0.00s)832niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/nix-cache-info (0.00s)833niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/listing_key,_narinfo_type (0.00s)834niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/realisation_plus_in_output (0.00s)835niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/build_log_question_mark (0.00s)836niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/build_log (0.00s)837niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/realisation (0.00s)838niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/narinfo (0.00s)839niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/listing (0.00s)840niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/nar_xz (0.00s)841niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/absolute (0.00s)842niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/traversal_nar (0.00s)843niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/build_log_equals (0.00s)844niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/nar_key,_narinfo_type (0.00s)845niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/build_log_home-manager_file (0.00s)846niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/index.html (0.00s)847niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/nar_plain (0.00s)848niks3-go-unit-tests> --- PASS: TestIsValidUploadKey/nar_zst (0.00s)849niks3-go-unit-tests> 2026/06/28 09:21:07 INFO OIDC provider initialized name=test850niks3-go-unit-tests> 2026/06/28 09:21:07 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_closures851niks3-go-unit-tests> === RUN TestUploadHandlersRejectOversizedBody/create_pending_closure852niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/create_pending_closure853niks3-go-unit-tests> === RUN TestUploadHandlersRejectOversizedBody/complete_multipart854niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/complete_multipart855niks3-go-unit-tests> === RUN TestUploadHandlersRejectOversizedBody/request_more_parts856niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/request_more_parts857niks3-go-unit-tests> === CONT TestUploadHandlersRejectOversizedBody/create_pending_closure858niks3-go-unit-tests> === CONT TestUploadHandlersRejectOversizedBody/request_more_parts859niks3-go-unit-tests> === CONT TestUploadHandlersRejectOversizedBody/complete_multipart860niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received request for more parts method=POST path=/861niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/862niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete multipart upload request method=POST path=/863niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Request failed, retrying attempt=2 max_attempts=6 backoff=188.093805ms error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures864niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Request failed, retrying attempt=3 max_attempts=6 backoff=404.09063ms error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures865niks3-go-unit-tests> 2026-06-28 09:21:08.348 UTC [1294] ERROR: relation "goose_db_version" does not exist at character 36866niks3-go-unit-tests> 2026-06-28 09:21:08.348 UTC [1294] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC867niks3-go-unit-tests> 2026-06-28 09:21:08.350 UTC [1296] ERROR: relation "goose_db_version" does not exist at character 36868niks3-go-unit-tests> 2026-06-28 09:21:08.350 UTC [1296] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC869niks3-go-unit-tests> 2026-06-28 09:21:08.350 UTC [1295] ERROR: relation "goose_db_version" does not exist at character 36870niks3-go-unit-tests> 2026-06-28 09:21:08.350 UTC [1295] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC871niks3-go-unit-tests> 2026-06-28 09:21:08.350 UTC [1297] ERROR: relation "goose_db_version" does not exist at character 36872niks3-go-unit-tests> 2026-06-28 09:21:08.350 UTC [1297] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC873niks3-go-unit-tests> 2026-06-28 09:21:08.356 UTC [1298] ERROR: relation "goose_db_version" does not exist at character 36874niks3-go-unit-tests> 2026-06-28 09:21:08.356 UTC [1298] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC875niks3-go-unit-tests> 2026-06-28 09:21:08.358 UTC [1299] ERROR: relation "goose_db_version" does not exist at character 36876niks3-go-unit-tests> 2026-06-28 09:21:08.358 UTC [1299] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC877niks3-go-unit-tests> 2026-06-28 09:21:08.359 UTC [1300] ERROR: relation "goose_db_version" does not exist at character 36878niks3-go-unit-tests> 2026-06-28 09:21:08.359 UTC [1300] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC879niks3-go-unit-tests> 2026-06-28 09:21:08.361 UTC [1301] ERROR: relation "goose_db_version" does not exist at character 36880niks3-go-unit-tests> 2026-06-28 09:21:08.361 UTC [1301] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC881niks3-go-unit-tests> 2026-06-28 09:21:08.428 UTC [1302] ERROR: relation "goose_db_version" does not exist at character 36882niks3-go-unit-tests> 2026-06-28 09:21:08.428 UTC [1302] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC883niks3-go-unit-tests> 2026-06-28 09:21:08.439 UTC [1303] ERROR: relation "goose_db_version" does not exist at character 36884niks3-go-unit-tests> 2026-06-28 09:21:08.439 UTC [1303] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC885niks3-go-unit-tests> 2026-06-28 09:21:08.455 UTC [1304] ERROR: relation "goose_db_version" does not exist at character 36886niks3-go-unit-tests> 2026-06-28 09:21:08.455 UTC [1304] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC887niks3-go-unit-tests> 2026-06-28 09:21:08.457 UTC [1305] ERROR: relation "goose_db_version" does not exist at character 36888niks3-go-unit-tests> 2026-06-28 09:21:08.457 UTC [1305] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC889niks3-go-unit-tests> 2026-06-28 09:21:08.465 UTC [1306] ERROR: relation "goose_db_version" does not exist at character 36890niks3-go-unit-tests> 2026-06-28 09:21:08.465 UTC [1306] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC891niks3-go-unit-tests> 2026-06-28 09:21:08.479 UTC [1307] ERROR: relation "goose_db_version" does not exist at character 36892niks3-go-unit-tests> 2026-06-28 09:21:08.479 UTC [1307] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC893niks3-go-unit-tests> 2026-06-28 09:21:08.482 UTC [1308] ERROR: relation "goose_db_version" does not exist at character 36894niks3-go-unit-tests> 2026-06-28 09:21:08.482 UTC [1308] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC895niks3-go-unit-tests> 2026-06-28 09:21:08.483 UTC [1309] ERROR: relation "goose_db_version" does not exist at character 36896niks3-go-unit-tests> 2026-06-28 09:21:08.483 UTC [1309] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC897niks3-go-unit-tests> 2026-06-28 09:21:08.486 UTC [1310] ERROR: relation "goose_db_version" does not exist at character 36898niks3-go-unit-tests> 2026-06-28 09:21:08.486 UTC [1310] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC899niks3-go-unit-tests> 2026-06-28 09:21:08.488 UTC [1311] ERROR: relation "goose_db_version" does not exist at character 36900niks3-go-unit-tests> 2026-06-28 09:21:08.488 UTC [1311] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC901niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectOversizedBody (0.15s)902niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectOversizedBody/request_more_parts (0.03s)903niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectOversizedBody/complete_multipart (0.03s)904niks3-go-unit-tests> --- PASS: TestUploadHandlersRejectOversizedBody/create_pending_closure (0.57s)905niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (92.27ms)906niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (172.63ms)907niks3-go-unit-tests> 2026-06-28 09:21:08.585 UTC [1312] ERROR: relation "goose_db_version" does not exist at character 36908niks3-go-unit-tests> 2026-06-28 09:21:08.585 UTC [1312] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC909niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (176.62ms)910niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (116.65ms)911niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (92.61ms)912niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (92.73ms)913niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (173.84ms)914niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (167.26ms)915niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (168.03ms)916niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (176.05ms)917niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (93.29ms)918niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (125.46ms)919niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (172.67ms)920niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (1.88ms)921niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.59ms)922niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.54ms)923niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.09ms)924niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.34ms)925niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.45ms)926niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.77ms)927niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.7ms)928niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (2.46ms)929niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726930niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.21ms)931niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.42ms)932niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.78ms)933niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (4.11ms)934niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (4.42ms)935niks3-go-unit-tests> 2026-06-28 09:21:08.593 UTC [1313] ERROR: relation "goose_db_version" does not exist at character 36936niks3-go-unit-tests> 2026-06-28 09:21:08.593 UTC [1313] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC937niks3-go-unit-tests> 2026-06-28 09:21:08.593 UTC [1315] ERROR: relation "goose_db_version" does not exist at character 36938niks3-go-unit-tests> 2026-06-28 09:21:08.593 UTC [1315] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC939niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.63ms)940niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726941niks3-go-unit-tests> 2026-06-28 09:21:08.594 UTC [1316] ERROR: relation "goose_db_version" does not exist at character 36942niks3-go-unit-tests> 2026-06-28 09:21:08.594 UTC [1316] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC943niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.35ms)944niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726945niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (6.73ms)946niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726947niks3-go-unit-tests> 2026-06-28 09:21:08.595 UTC [1318] ERROR: relation "goose_db_version" does not exist at character 36948niks3-go-unit-tests> 2026-06-28 09:21:08.595 UTC [1318] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC949niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (6.22ms)950niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726951niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (5.35ms)952niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 1953niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.87ms)954niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726955niks3-go-unit-tests> 2026-06-28 09:21:08.596 UTC [1317] ERROR: relation "goose_db_version" does not exist at character 36956niks3-go-unit-tests> 2026-06-28 09:21:08.596 UTC [1317] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC957niks3-go-unit-tests> 2026-06-28 09:21:08.596 UTC [1319] ERROR: relation "goose_db_version" does not exist at character 36958niks3-go-unit-tests> 2026-06-28 09:21:08.596 UTC [1319] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC959niks3-go-unit-tests> 2026-06-28 09:21:08.596 UTC [1314] ERROR: relation "goose_db_version" does not exist at character 36960niks3-go-unit-tests> 2026-06-28 09:21:08.596 UTC [1314] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC961niks3-go-unit-tests> 2026-06-28 09:21:08.597 UTC [1320] ERROR: relation "goose_db_version" does not exist at character 36962niks3-go-unit-tests> 2026-06-28 09:21:08.597 UTC [1320] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC963niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (7.01ms)964niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726965niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (8.11ms)966niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726967niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (5ms)968niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 1969niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.88ms)970niks3-go-unit-tests> 2026-06-28 09:21:08.599 UTC [1321] ERROR: relation "goose_db_version" does not exist at character 36971niks3-go-unit-tests> 2026-06-28 09:21:08.599 UTC [1321] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC972niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 1973niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (8.74ms)974niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.86ms)975niks3-go-unit-tests> 2026-06-28 09:21:08.599 UTC [1322] ERROR: relation "goose_db_version" does not exist at character 36976niks3-go-unit-tests> 2026-06-28 09:21:08.599 UTC [1322] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC977niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726978niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 1979niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.71ms)980niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 1981niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.78ms)982niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 1983niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (8.15ms)984niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726985niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (8.73ms)986niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726987niks3-go-unit-tests> 2026-06-28 09:21:08.600 UTC [1323] ERROR: relation "goose_db_version" does not exist at character 36988niks3-go-unit-tests> 2026-06-28 09:21:08.600 UTC [1323] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC989niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.23ms)990niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 1991niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (8.63ms)992niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726993niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (9.69ms)994niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 20251218171726995niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1325] ERROR: relation "goose_db_version" does not exist at character 36996niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1325] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC997niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1326] ERROR: relation "goose_db_version" does not exist at character 36998niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1326] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC999niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1327] ERROR: relation "goose_db_version" does not exist at character 361000niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1327] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1001niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1324] ERROR: relation "goose_db_version" does not exist at character 361002niks3-go-unit-tests> 2026-06-28 09:21:08.602 UTC [1324] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1003niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (4.33ms)1004niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11005niks3-go-unit-tests> 2026-06-28 09:21:08.603 UTC [1329] ERROR: relation "goose_db_version" does not exist at character 361006niks3-go-unit-tests> 2026-06-28 09:21:08.603 UTC [1329] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1007niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.18ms)1008niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11009niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (4.19ms)1010niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11011niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.3ms)1012niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11013niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received cleanup request method=DELETE path=/api/pending_closures1014niks3-go-unit-tests> 2026-06-28 09:21:08.604 UTC [1330] ERROR: relation "goose_db_version" does not exist at character 361015niks3-go-unit-tests> 2026-06-28 09:21:08.604 UTC [1330] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1016niks3-go-unit-tests> 2026-06-28 09:21:08.604 UTC [1331] ERROR: relation "goose_db_version" does not exist at character 361017niks3-go-unit-tests> 2026-06-28 09:21:08.604 UTC [1331] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1018niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (3.16ms)1019niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11020niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (13.5ms)1021niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1022niks3-go-unit-tests> 2026-06-28 09:21:08.605 UTC [1328] ERROR: relation "goose_db_version" does not exist at character 361023niks3-go-unit-tests> 2026-06-28 09:21:08.605 UTC [1328] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1024niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Aborted multipart uploads count=01025niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (5.09ms)1026niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11027niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1028niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1029niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1030niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Created nix-cache-info in bucket bucket=bucket61031niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1032niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.1ms)1033niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1034niks3-go-unit-tests> 2026/06/28 09:21:08 WARN mTLS auth: subject not in bound subjects subject="CN=reader"1035niks3-go-unit-tests> 2026/06/28 09:21:08 WARN mTLS auth: subject not in bound subjects subject="CN=writer"1036niks3-go-unit-tests> --- PASS: TestService_NativeMTLS (0.75s)1037niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Created nix-cache-info in bucket bucket=bucket91038niks3-go-unit-tests> --- PASS: TestReadProxyNarinfoAlreadyDecompressed (0.75s)1039niks3-go-unit-tests> --- PASS: TestReadProxyNarStreaming (0.75s)1040niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (19.99ms)1041niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (21.03ms)1042niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (21.86ms)1043niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.14ms)1044niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261045niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.94ms)1046niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.79ms)1047niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (24.65ms)1048niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.44ms)1049niks3-go-unit-tests> --- PASS: TestCreatePendingClosure_SmallNARUsesSimplePUT (0.76s)1050niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (5.11ms)1051niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11052niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (16ms)1053niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.91ms)1054niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (14.22ms)1055niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (19.95ms)1056niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (16.59ms)1057niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (17.77ms)1058niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (8.28ms)1059niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261060niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received cleanup request method=DELETE path=/api/pending_closures1061niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (8.43ms)1062niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261063niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (17.93ms)1064niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (9.81ms)1065niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261066niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (15.7ms)1067niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (25.25ms)1068niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (18.71ms)1069niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (16.78ms)1070niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (17.55ms)1071niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Aborted multipart uploads count=11072niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.39ms)1073niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.59ms)1074niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.87ms)1075niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (15.56ms)1076niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (15.5ms)1077niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.87ms)1078niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.87ms)1079niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.69ms)1080niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11081niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (7.42ms)1082niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261083niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (16.32ms)1084niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.19ms)1085niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.02ms)1086niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.6ms)1087niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (12.07ms)1088niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (15.63ms)1089niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (4.6ms)1090niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11091niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (12.82ms)1092niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.23ms)1093niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (17.65ms)1094niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.41ms)1095niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.97ms)1096niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.32ms)1097niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.46ms)1098niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (2.07ms)1099niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (4.52ms)1100niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11101niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1102niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.54ms)1103niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261104niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.4ms)1105niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261106niks3-go-unit-tests> 2026-06-28 09:21:08.629 UTC [1296] ERROR: Closure does not exist: id=11107niks3-go-unit-tests> 2026-06-28 09:21:08.629 UTC [1296] CONTEXT: PL/pgSQL function commit_pending_closure(bigint) line 16 at RAISE1108niks3-go-unit-tests> 2026-06-28 09:21:08.629 UTC [1296] STATEMENT: -- name: CommitPendingClosure :exec1109niks3-go-unit-tests> SELECT commit_pending_closure($1::bigint)1110niks3-go-unit-tests> 1111niks3-go-unit-tests> --- PASS: TestService_cleanupPendingClosuresHandler (0.77s)1112niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Authentication failed token_preview=wrongtoken token_length=10 reason="static API token mismatch"1113niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware (0.77s)1114niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (4.82ms)1115niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11116niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.55ms)1117niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.68ms)1118niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.63ms)1119niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.27ms)1120niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261121niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (15.74ms)1122niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.5ms)1123niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261124niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.56ms)1125niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.66ms)1126niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261127niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Created nix-cache-info in bucket bucket=bucket151128niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (4.44ms)1129niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261130niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.65ms)1131niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11132niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.59ms)1133niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.87ms)1134niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261135niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11136niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (4.61ms)1137niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261138niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.54ms)1139niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261140niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (4.08ms)1141niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261142niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.81ms)1143niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261144niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (4.29ms)1145niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261146niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (5.01ms)1147niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261148niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (4.38ms)1149niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261150niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.97ms)1151niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.92ms)1152niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11153niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.51ms)1154niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11155niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.5ms)1156niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11157niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.91ms)1158niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11159niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11160niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (3.12ms)1161niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.56ms)1162niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11163niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.67ms)1164niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.73ms)1165niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.5ms)1166niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11167niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (1.93ms)1168niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11169niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.44ms)1170niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261171niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.38ms)1172niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.59ms)1173niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11174niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11175niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.51ms)1176niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11177niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.67ms)1178niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11179niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261180niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261181niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (3.39ms)1182niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261183niks3-go-unit-tests> --- PASS: TestReadProxyInvalidPath (0.77s)1184niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Created nix-cache-info in bucket bucket=bucket201185niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.01ms)1186niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11187niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (1.93ms)1188niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (2.54ms)1189niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2ms)1190niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11191niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20241026095416_initial_model.sql (14.17ms)1192niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261193niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11194niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (2.17ms)1195niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11196niks3-go-unit-tests> === RUN TestService_AuthMiddleware_OIDC/valid_OIDC_token1197niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/valid_OIDC_token1198niks3-go-unit-tests> === RUN TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected1199niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected1200niks3-go-unit-tests> === RUN TestService_AuthMiddleware_OIDC/malformed_token_rejected1201niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/malformed_token_rejected1202niks3-go-unit-tests> === RUN TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured1203niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured1204niks3-go-unit-tests> === CONT TestService_AuthMiddleware_OIDC/valid_OIDC_token1205niks3-go-unit-tests> === CONT TestService_AuthMiddleware_OIDC/malformed_token_rejected1206niks3-go-unit-tests> === CONT TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected1207niks3-go-unit-tests> === CONT TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured1208niks3-go-unit-tests> 2026/06/28 09:21:08 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]1209niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1210niks3-go-unit-tests> --- PASS: TestService_healthCheckHandler (0.78s)1211niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Authentication failed token_preview=eyJhbGciOi...tI04YCn0JQ 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]1212niks3-go-unit-tests> 2026/06/28 09:21:08 INFO OIDC auth successful provider=test1213niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (1.63ms)1214niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11215niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_MTLSProxyHeader (0.78s)1216niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_OIDC (0.78s)1217niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured (0.00s)1218niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_OIDC/malformed_token_rejected (0.00s)1219niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected (0.00s)1220niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_OIDC/valid_OIDC_token (0.00s)1221niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1222niks3-go-unit-tests> 2026/06/28 09:21:08 WARN mTLS auth: subject not in bound subjects subject="CN=writer"1223niks3-go-unit-tests> --- PASS: TestService_ReadAuthMiddleware (0.78s)1224niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1225niks3-go-unit-tests> 2026/06/28 09:21:08 WARN mTLS auth: subject not in bound subjects subject="CN=untrusted,O=Other"1226niks3-go-unit-tests> 2026/06/28 09:21:08 WARN mTLS auth: bound subjects configured but subject DN unavailable1227niks3-go-unit-tests> 2026/06/28 09:21:08 WARN mTLS auth: subject not in bound subjects subject="CN=untrusted"1228niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_MTLSBoundSubjects (0.78s)1229niks3-go-unit-tests> --- PASS: TestReadProxyRangeRequest (0.78s)1230niks3-go-unit-tests> --- PASS: TestService_Rustfstest (0.78s)1231niks3-go-unit-tests> --- PASS: TestReadProxyDisabled (0.78s)1232niks3-go-unit-tests> --- PASS: TestReadProxy404 (0.78s)1233niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Created nix-cache-info in bucket bucket=bucket241234niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Created nix-cache-info in bucket bucket=bucket361235niks3-go-unit-tests> --- PASS: TestReadProxyRootRedirectsToIndexHTML (0.78s)1236niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251210153512_drop_unused_gin_index.sql (1.47ms)1237niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1238niks3-go-unit-tests> 2026/06/28 09:21:08 OK 20251218171726_add_pins.sql (2.8ms)1239niks3-go-unit-tests> 2026/06/28 09:21:08 goose: successfully migrated database to version: 202512181717261240niks3-go-unit-tests> 2026/06/28 09:21:08 OK 1_commit_pending_closure.sql (1.89ms)1241niks3-go-unit-tests> 2026/06/28 09:21:08 goose: up to current file version: 11242niks3-go-unit-tests> --- PASS: TestResurrectedObjectNotDeleted (0.79s)1243niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1244niks3-go-unit-tests> 2026/06/28 09:21:08 ERROR Multipart upload not found error="no rows in result set" upload_id=does-not-exist object_key=nar/0000000000000000000000000000000000000000000000000000.nar.zst1245niks3-go-unit-tests> --- PASS: TestCompleteMultipartUnregistered (0.79s)1246niks3-go-unit-tests> === NAME TestPinProtectsFromGC1247niks3-go-unit-tests> client_integration_test.go:645: Pinned store path: /build/TestPinProtectsFromGC3776072089/001/store/0v48nx66i60n03n8sgbz10bh0z0m5y7d-pinned-file.txt1248niks3-go-unit-tests> client_integration_test.go:646: Unpinned store path: /build/TestPinProtectsFromGC3776072089/001/store/jl3i6i86d7spsxzl8x384zfi36islx9m-unpinned-file.txt1249niks3-go-unit-tests> === NAME TestNARDeduplicationMetadataUploadBug1250niks3-go-unit-tests> metadata_upload_test.go:48: First store path: /build/TestNARDeduplicationMetadataUploadBug928997608/001/store/jw1fw4ll72gr42l0lgczdn0i8m0syv0b-file1.txt1251niks3-go-unit-tests> --- PASS: TestReadProxyNarinfo (0.81s)1252niks3-go-unit-tests> --- PASS: TestReadProxyHead (0.82s)1253niks3-go-unit-tests> --- PASS: TestReadProxyConditionalGet (0.82s)1254niks3-go-unit-tests> === NAME TestClientIntegration1255niks3-go-unit-tests> client_integration_test.go:276: Created store path: /build/TestClientIntegration2758355966/002/store/jh69cy7ywpalshh92ydy3cln54sakhsp-test-file.txt1256niks3-go-unit-tests> === NAME TestClientMultipleUploads1257niks3-go-unit-tests> client_integration_test.go:338: Created store path 0: /build/TestClientMultipleUploads1257832417/001/store/mjqyiyr100v5c1a11jzibwa29pk6g4sp-test-file-0.txt1258niks3-go-unit-tests> === NAME TestClientWithDependencies1259niks3-go-unit-tests> client_integration_test.go:593: Built derivation: /build/TestClientWithDependencies2810950182/001/store/n5ql0b26j23km0psgaxxaqply4m47llr-test-script1260niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Request failed, retrying attempt=4 max_attempts=6 backoff=853.95901ms error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures1261niks3-go-unit-tests> client_integration_test.go:595: Found 1 dependencies (including self)1262niks3-go-unit-tests> === NAME TestClientMultipleUploads1263niks3-go-unit-tests> client_integration_test.go:338: Created store path 1: /build/TestClientMultipleUploads1257832417/001/store/0rkk3zid2k80mam4d2pv5vdnp65z4saj-test-file-1.txt1264niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1265niks3-go-unit-tests> === NAME TestClientCADerivations1266niks3-go-unit-tests> client_ca_test.go:136: Built CA derivation: /build/TestClientCADerivations522523216/001/store/vnchyn7wnn3vyavbpq4b3255vsqh8ag3-ca-test1267niks3-go-unit-tests> === NAME TestClientMultipleUploads1268niks3-go-unit-tests> client_integration_test.go:338: Created store path 2: /build/TestClientMultipleUploads1257832417/001/store/5gyxxywzvirmhi7yvh1z970fqzdfjq1f-test-file-2.txt1269niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received cleanup request method=DELETE path=/api/pending_closures1270niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Aborted multipart uploads count=11271niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1272niks3-go-unit-tests> --- PASS: TestMultipartCleanup (0.89s)1273niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1274niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1275niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 0v48nx66i60n03n8sgbz10bh0z0m5y7d-pinned-file.txt (128B)1276niks3-go-unit-tests> === NAME TestClientCADerivations1277niks3-go-unit-tests> client_ca_test.go:139: Found 1 dependencies (including self)1278niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Authentication failed token_preview=invalid-token token_length=13 reason="static API token mismatch"1279niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1280niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading n5ql0b26j23km0psgaxxaqply4m47llr-test-script (136B)1281niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1282niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=1 count=11283niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 narinfos1284niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1285niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=1 count=11286niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 narinfos1287niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1288niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1289niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1290niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11291niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (73ms)1292niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1293niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading jh69cy7ywpalshh92ydy3cln54sakhsp-test-file.txt (152B)1294niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11295niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (45ms)1296niks3-go-unit-tests> === NAME TestClientWithDependencies1297niks3-go-unit-tests> client_integration_test.go:597: Skipping nix copy test - isolated store (/build/TestClientWithDependencies2810950182/001/store) requires matching store prefix1298niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1299niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=1 count=11300niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 narinfos1301niks3-go-unit-tests> --- PASS: TestClientWithDependencies (0.92s)1302niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1303niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11304niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (81ms)1305niks3-go-unit-tests> === NAME TestClientIntegration1306niks3-go-unit-tests> client_integration_test.go:292: Retrieved narinfo from S3:1307niks3-go-unit-tests> StorePath: /build/TestClientIntegration2758355966/002/store/jh69cy7ywpalshh92ydy3cln54sakhsp-test-file.txt1308niks3-go-unit-tests> URL: nar/11l1b7hsy9g9pz8i2rcn4n128l6pyr2yf58d49r12hr5caw9dzk1.nar.zst1309niks3-go-unit-tests> Compression: zstd1310niks3-go-unit-tests> NarHash: sha256:11l1b7hsy9g9pz8i2rcn4n128l6pyr2yf58d49r12hr5caw9dzk11311niks3-go-unit-tests> NarSize: 1521312niks3-go-unit-tests> References: 1313niks3-go-unit-tests> CA: fixed:r:sha256:11l1b7hsy9g9pz8i2rcn4n128l6pyr2yf58d49r12hr5caw9dzk11314niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1315niks3-go-unit-tests> client_integration_test.go:293: Retrieved .ls file from S3 (compressed size: 77 bytes)1316niks3-go-unit-tests> client_integration_test.go:293: Decompressed .ls content (64 bytes):1317niks3-go-unit-tests> {"version":1,"root":{"type":"regular","size":39,"narOffset":96}}1318niks3-go-unit-tests> client_integration_test.go:296: Testing garbage collection...1319niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1320niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading jw1fw4ll72gr42l0lgczdn0i8m0syv0b-file1.txt (160B)1321niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1322niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=1 count=11323niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 narinfos1324niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1325niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11326niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (100ms)1327niks3-go-unit-tests> === NAME TestNARDeduplicationMetadataUploadBug1328niks3-go-unit-tests> metadata_upload_test.go:54: Retrieved narinfo from S3:1329niks3-go-unit-tests> StorePath: /build/TestNARDeduplicationMetadataUploadBug928997608/001/store/jw1fw4ll72gr42l0lgczdn0i8m0syv0b-file1.txt1330niks3-go-unit-tests> URL: nar/1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf.nar.zst1331niks3-go-unit-tests> Compression: zstd1332niks3-go-unit-tests> NarHash: sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1333niks3-go-unit-tests> NarSize: 1601334niks3-go-unit-tests> References: 1335niks3-go-unit-tests> CA: fixed:r:sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1336niks3-go-unit-tests> metadata_upload_test.go:55: Retrieved .ls file from S3 (compressed size: 77 bytes)1337niks3-go-unit-tests> metadata_upload_test.go:55: Decompressed .ls content (64 bytes):1338niks3-go-unit-tests> {"version":1,"root":{"type":"regular","size":44,"narOffset":96}}1339niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Starting cleanup of old closures method=DELETE path=/api/closures1340niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Garbage collection started1341niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Aborted multipart uploads count=01342niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Force mode enabled - objects will be deleted immediately without grace period1343niks3-go-unit-tests> --- PASS: TestGCBugBareHashReferences (0.97s)1344niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1345niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1346niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1347niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1348niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 3 paths to 127.0.0.1 (0 already cached)1349niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading mjqyiyr100v5c1a11jzibwa29pk6g4sp-test-file-0.txt (160B)1350niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 5gyxxywzvirmhi7yvh1z970fqzdfjq1f-test-file-2.txt (160B)1351niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 0rkk3zid2k80mam4d2pv5vdnp65z4saj-test-file-1.txt (160B)1352niks3-go-unit-tests> === NAME TestNARDeduplicationMetadataUploadBug1353niks3-go-unit-tests> metadata_upload_test.go:64: Second store path (same content): /build/TestNARDeduplicationMetadataUploadBug928997608/001/store/d2blipydq8pppxh4p0danxskajsxrr5q-file2.txt1354niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1355niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading vnchyn7wnn3vyavbpq4b3255vsqh8ag3-ca-test (144B)1356niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1357niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=1 count=11358niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign1359niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=2 count=11360niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/3/sign1361niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=3 count=11362niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 3 narinfos1363niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1364niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=1 count=11365niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 narinfos1366niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1367niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1368niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1369niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11370niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11371niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (76ms)1372niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)1373niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading jl3i6i86d7spsxzl8x384zfi36islx9m-unpinned-file.txt (128B)1374niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1375niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=21376niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/3/complete1377niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=31378niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (107ms)1379niks3-go-unit-tests> === NAME TestClientMultipleUploads1380niks3-go-unit-tests> client_integration_test.go:349: Uploaded 3 paths in 134.402377ms1381niks3-go-unit-tests> === NAME TestClientCADerivations1382niks3-go-unit-tests> client_ca_test.go:180: Narinfo contains CA field: StorePath: /build/TestClientCADerivations522523216/001/store/vnchyn7wnn3vyavbpq4b3255vsqh8ag3-ca-test1383niks3-go-unit-tests> URL: nar/04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n.nar.zst1384niks3-go-unit-tests> Compression: zstd1385niks3-go-unit-tests> NarHash: sha256:04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n1386niks3-go-unit-tests> NarSize: 1441387niks3-go-unit-tests> References: 1388niks3-go-unit-tests> Deriver: /build/TestClientCADerivations522523216/001/store/5m5g0h2fr3rlas0c78z4sbwqwv6ncr7n-ca-test.drv1389niks3-go-unit-tests> CA: fixed:r:sha256:04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n1390niks3-go-unit-tests> client_ca_test.go:185: Checking for realisation files in S3...1391niks3-go-unit-tests> client_ca_test.go:207: No realisation files uploaded - this is expected for locally built CA derivations1392niks3-go-unit-tests> client_ca_test.go:208: Locally built CA derivations don't have DrvOutput IDs until they're substituted from a cache1393niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign1394niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=2 count=11395niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 narinfos1396niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1397niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=21398niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (74ms)1399niks3-go-unit-tests> --- PASS: TestClientMultipleUploads (1.02s)1400niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received create pin request method=POST path=/api/pins/myapp1401niks3-go-unit-tests> === NAME TestOrphanedObjectsGC1402niks3-go-unit-tests> orphaned_objects_gc_test.go:290: GC Test Summary:1403niks3-go-unit-tests> orphaned_objects_gc_test.go:291: - Kept: 2 objects from closure A1404niks3-go-unit-tests> orphaned_objects_gc_test.go:292: - Deleted: 2 objects from closure B1405niks3-go-unit-tests> orphaned_objects_gc_test.go:293: - Deleted: 6 orphaned chain objects (X1->X2->X3)1406niks3-go-unit-tests> orphaned_objects_gc_test.go:294: - Deleted: 2 orphaned single objects (Y)1407niks3-go-unit-tests> orphaned_objects_gc_test.go:295: - Total deleted: 10 objects1408niks3-go-unit-tests> --- PASS: TestOrphanedObjectsGC (1.04s)1409niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Created/updated pin name=myapp store_path=/build/TestPinProtectsFromGC3776072089/001/store/0v48nx66i60n03n8sgbz10bh0z0m5y7d-pinned-file.txt narinfo_key=0v48nx66i60n03n8sgbz10bh0z0m5y7d.narinfo1410niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Starting cleanup of old closures method=DELETE path=/api/closures1411niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Garbage collection started1412niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1413niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Aborted multipart uploads count=01414niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Force mode enabled - objects will be deleted immediately without grace period1415niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed multipart upload object_key=nar/dadb44fdadb44fdadb44fdadb44f000000000000000000000000.nar.zst upload_id=ZTNlZmI3MjYtYjhiYi00M2E4LTkwMmYtM2QyNzBlNDdiNTU3LjFjYTg5MGZjLWJkN2EtNGNmMi1hYTRkLTY0NzllZDllYzc0OHgxNzgyNjM4NDY4NjE0NzI2MDQ3 parts=101416niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1417niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1418niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11419niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1420niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1421niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Object in database but missing from S3 key=dadb44fdadb44fdadb44fdadb44f0000.narinfo1422niks3-go-unit-tests> 2026/06/28 09:21:08 WARN Found objects in DB but missing from S3, will re-upload count=11423niks3-go-unit-tests> --- PASS: TestService_verifyS3Integrity (1.06s)1424niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed multipart upload object_key=nar/0000000000000000000000000000000000000000000000000000.nar.zst upload_id=ZTNlZmI3MjYtYjhiYi00M2E4LTkwMmYtM2QyNzBlNDdiNTU3LjMxN2I0MzAzLTQzODktNDc2ZS1iMzM2LTJiZTE4MDVlMjRhOXgxNzgyNjM4NDY4NjE0NzQ5Mzk3 parts=101425niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1426niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=11427niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received get closure request method=GET path=/api/closures/000000000000000000000000000000001428niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1429niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Starting cleanup of old closures method=DELETE path=/api/closures1430niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Aborted multipart uploads count=01431niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received uploads request method=POST path=/api/pending_closures1432niks3-go-unit-tests> 2026/06/28 09:21:08 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=01433niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 0 paths to 127.0.0.1 (1 already cached)1434niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Vacuumed table table=pending_closures1435niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Vacuumed table table=pending_objects1436niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Vacuumed table table=multipart_uploads1437niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign1438niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Signed narinfos id=2 count=11439niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Uploading 1 narinfos1440niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Vacuumed table table=closures1441niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Vacuumed table table=objects1442niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1443niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed upload id=21444niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Upload complete. (61ms)1445niks3-go-unit-tests> === NAME TestNARDeduplicationMetadataUploadBug1446niks3-go-unit-tests> metadata_upload_test.go:76: Retrieved narinfo from S3:1447niks3-go-unit-tests> StorePath: /build/TestNARDeduplicationMetadataUploadBug928997608/001/store/d2blipydq8pppxh4p0danxskajsxrr5q-file2.txt1448niks3-go-unit-tests> URL: nar/1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf.nar.zst1449niks3-go-unit-tests> Compression: zstd1450niks3-go-unit-tests> NarHash: sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1451niks3-go-unit-tests> NarSize: 1601452niks3-go-unit-tests> References: 1453niks3-go-unit-tests> CA: fixed:r:sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf1454niks3-go-unit-tests> metadata_upload_test.go:77: Retrieved .ls file from S3 (compressed size: 62 bytes)1455niks3-go-unit-tests> metadata_upload_test.go:77: Decompressed .ls content (49 bytes):1456niks3-go-unit-tests> {"version":1,"root":{"type":"regular","size":44}}1457niks3-go-unit-tests> --- PASS: TestNARDeduplicationMetadataUploadBug (1.08s)1458niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1459niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Completed multipart upload object_key=nar/gggggggggggggggggggggggggggggg0100000000000000000000.nar.zst upload_id=ZTNlZmI3MjYtYjhiYi00M2E4LTkwMmYtM2QyNzBlNDdiNTU3LmNlZmYzNjAyLTI1NDMtNGE3NC05M2FiLWM3ZDFkMjM5NzdkNHgxNzgyNjM4NDY4NjQ2OTMwMDQ2 parts=121460niks3-go-unit-tests> --- PASS: TestRedundantMultipartUpload (1.11s)1461niks3-go-unit-tests> 2026/06/28 09:21:08 INFO Received get closure request method=GET path=/api/closures/000000000000000000000000000000001462niks3-go-unit-tests> --- PASS: TestService_createPendingClosureHandler (1.12s)1463niks3-go-unit-tests> === NAME TestClientCADerivations1464niks3-go-unit-tests> client_ca_test.go:258: nix copy output: warning: you don't have Internet access; disabling some network-dependent features1465niks3-go-unit-tests> warning: failed to create TLS context for AWS credential providers; SSO, STS WebIdentity, and ECS container authentication will be unavailable1466niks3-go-unit-tests> error: binary cache 's3://bucket15?endpoint=http://localhost:41691®ion=eu-west-1' is for Nix stores with prefix '/nix/store', not '/build/TestClientCADerivations522523216/001/store'1467niks3-go-unit-tests> client_ca_test.go:259: nix copy failed (might be expected with isolated stores): exit status 11468niks3-go-unit-tests> --- PASS: TestClientCADerivations (1.13s)1469niks3-go-unit-tests> === NAME TestOrphanedObjectsGCStressTest1470niks3-go-unit-tests> orphaned_objects_gc_test.go:425: Created 10 active closures, 5 to-delete closures, 20 orphaned chains1471niks3-go-unit-tests> orphaned_objects_gc_test.go:446: Marked 210 objects for deletion1472niks3-go-unit-tests> orphaned_objects_gc_test.go:509: Stress test completed successfully:1473niks3-go-unit-tests> orphaned_objects_gc_test.go:510: - Active objects preserved: 201474niks3-go-unit-tests> orphaned_objects_gc_test.go:511: - Objects deleted: 2101475niks3-go-unit-tests> orphaned_objects_gc_test.go:512: - Total GC'd: 2101476niks3-go-unit-tests> --- PASS: TestOrphanedObjectsGCStressTest (1.54s)1477niks3-go-unit-tests> 2026/06/28 09:21:09 WARN Request failed, retrying attempt=5 max_attempts=6 backoff=1.518474407s error="Post \"http://localhost:19999/api/pending_closures\": dial tcp [::1]:19999: connect: connection refused" url=http://localhost:19999/api/pending_closures1478niks3-go-unit-tests> 2026/06/28 09:21:10 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=108 objects_failed=01479niks3-go-unit-tests> 2026/06/28 09:21:10 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=102 objects_failed=01480niks3-go-unit-tests> --- PASS: TestClientErrorHandling (0.00s)1481niks3-go-unit-tests> --- PASS: TestClientErrorHandling/InvalidStorePath (0.81s)1482niks3-go-unit-tests> --- PASS: TestClientErrorHandling/InvalidAuthToken (0.90s)1483niks3-go-unit-tests> --- PASS: TestClientErrorHandling/ServerNotAvailable (3.19s)1484niks3-go-unit-tests> 2026/06/28 09:21:12 WARN Rate limiter enabled after throttle name=s3-test rate=51485niks3-go-unit-tests> 2026/06/28 09:21:12 WARN S3 rate limit hit operation="complete multipart upload" error="Please reduce your request rate."1486niks3-go-unit-tests> === NAME TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle1487niks3-go-unit-tests> throttle_test.go:226: Proxy stats: total=14, throttled=10, completeMultipart=101488niks3-go-unit-tests> throttle_test.go:228: Rate limiter: enabled=true, rate=5.001489niks3-go-unit-tests> --- PASS: TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle (4.68s)1490niks3-go-unit-tests> 2026/06/28 09:21:12 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=228 objects_failed=01491niks3-go-unit-tests> 2026/06/28 09:21:12 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=222 objects_failed=01492niks3-go-unit-tests> 2026/06/28 09:21:14 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=336 objects_failed=01493niks3-go-unit-tests> 2026/06/28 09:21:14 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=330 objects_failed=01494niks3-go-unit-tests> 2026/06/28 09:21:16 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=438 objects_failed=01495niks3-go-unit-tests> 2026/06/28 09:21:16 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=438 objects_failed=01496niks3-go-unit-tests> 2026/06/28 09:21:18 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=537 objects_failed=01497niks3-go-unit-tests> 2026/06/28 09:21:18 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=546 objects_failed=01498niks3-go-unit-tests> 2026/06/28 09:21:20 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=642 objects_failed=01499niks3-go-unit-tests> 2026/06/28 09:21:20 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=657 objects_failed=01500niks3-go-unit-tests> 2026/06/28 09:21:22 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=744 objects_failed=01501niks3-go-unit-tests> 2026/06/28 09:21:22 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=756 objects_failed=01502niks3-go-unit-tests> 2026/06/28 09:21:24 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=852 objects_failed=01503niks3-go-unit-tests> 2026/06/28 09:21:24 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=864 objects_failed=01504niks3-go-unit-tests> 2026/06/28 09:21:26 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=957 objects_failed=01505niks3-go-unit-tests> 2026/06/28 09:21:26 INFO Garbage collection progress phase=cleanup_orphan_objects failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=972 objects_failed=01506niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Garbage collection completed failed-uploads-deleted=0 old-closures-deleted=1 objects-marked-for-deletion=3 objects-deleted-after-grace-period=1006 objects-failed-to-delete=01507niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=pending_closures1508niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=pending_objects1509niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=multipart_uploads1510niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=closures1511niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=objects1512niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Garbage collection completed failed-uploads-deleted=0 old-closures-deleted=1 objects-marked-for-deletion=3 objects-deleted-after-grace-period=1006 objects-failed-to-delete=01513niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=pending_closures1514niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=pending_objects1515niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=multipart_uploads1516niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=closures1517niks3-go-unit-tests> 2026/06/28 09:21:27 INFO Vacuumed table table=objects1518niks3-go-unit-tests> 2026/06/28 09:21:28 INFO Garbage collection progress phase="" failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=1006 objects_failed=01519niks3-go-unit-tests> === NAME TestClientIntegration1520niks3-go-unit-tests> client_integration_test.go:303: Objects in database after GC:1521niks3-go-unit-tests> client_integration_test.go:303: Successfully deleted all objects with GC --force1522niks3-go-unit-tests> --- PASS: TestClientIntegration (20.98s)1523niks3-go-unit-tests> 2026/06/28 09:21:28 INFO Garbage collection progress phase="" failed_uploads_deleted=0 old_closures_deleted=1 objects_marked=3 objects_deleted=1006 objects_failed=01524niks3-go-unit-tests> === NAME TestPinProtectsFromGC1525niks3-go-unit-tests> client_integration_test.go:708: Pin successfully protected closure from garbage collection1526niks3-go-unit-tests> --- PASS: TestPinProtectsFromGC (21.07s)1527niks3-go-unit-tests> PASS1528niks3-go-unit-tests> {"timestamp":"2026-06-28T09:21:28.929374679Z","level":"ERROR","fields":{"message":"Cannot perform graceful shutdown, other references exist err: GracefulShutdown"},"target":"rustfs::server::http","filename":"rustfs/src/server/http.rs","line_number":408,"threadName":"rustfs-worker","threadId":"ThreadId(763)"}1529niks3-go-unit-tests> Server stopped successfully.1530niks3-go-unit-tests> 2026-06-28 09:21:30.526 UTC [311] LOG: received smart shutdown request1531niks3-go-unit-tests> 2026-06-28 09:21:30.529 UTC [311] LOG: background worker "logical replication launcher" (PID 318) exited with exit code 11532niks3-go-unit-tests> 2026-06-28 09:21:30.532 UTC [313] LOG: shutting down1533niks3-go-unit-tests> 2026-06-28 09:21:30.535 UTC [313] LOG: checkpoint starting: shutdown immediate1534niks3-go-unit-tests> 2026-06-28 09:21:31.680 UTC [313] LOG: checkpoint complete: wrote 10064 buffers (61.4%); 0 WAL file(s) added, 0 removed, 10 recycled; write=0.172 s, sync=0.965 s, total=1.149 s; sync files=12382, longest=0.002 s, average=0.001 s; distance=166884 kB, estimate=166884 kB; lsn=0/B7E5D00, redo lsn=0/B7E5D001535niks3-go-unit-tests> 2026-06-28 09:21:31.753 UTC [311] LOG: database system is shut down1536niks3-go-unit-tests> Running OIDC tests...1537niks3-go-unit-tests> === RUN TestGlobMatch1538niks3-go-unit-tests> === PAUSE TestGlobMatch1539niks3-go-unit-tests> === RUN TestAudienceForIssuer1540niks3-go-unit-tests> === PAUSE TestAudienceForIssuer1541niks3-go-unit-tests> === RUN TestValidateToken_ValidToken1542niks3-go-unit-tests> === PAUSE TestValidateToken_ValidToken1543niks3-go-unit-tests> === RUN TestValidateToken_WrongAudience1544niks3-go-unit-tests> === PAUSE TestValidateToken_WrongAudience1545niks3-go-unit-tests> === RUN TestValidateToken_Expired1546niks3-go-unit-tests> === PAUSE TestValidateToken_Expired1547niks3-go-unit-tests> === RUN TestValidateToken_BoundClaimsMismatch1548niks3-go-unit-tests> === PAUSE TestValidateToken_BoundClaimsMismatch1549niks3-go-unit-tests> === RUN TestValidateToken_BoundSubjectMismatch1550niks3-go-unit-tests> === PAUSE TestValidateToken_BoundSubjectMismatch1551niks3-go-unit-tests> === RUN TestValidateToken_MultipleProviders1552niks3-go-unit-tests> === PAUSE TestValidateToken_MultipleProviders1553niks3-go-unit-tests> === RUN TestValidateToken_NoMatchingProvider1554niks3-go-unit-tests> === PAUSE TestValidateToken_NoMatchingProvider1555niks3-go-unit-tests> === CONT TestGlobMatch1556niks3-go-unit-tests> === RUN TestGlobMatch/foo_foo1557niks3-go-unit-tests> === PAUSE TestGlobMatch/foo_foo1558niks3-go-unit-tests> === RUN TestGlobMatch/foo_bar1559niks3-go-unit-tests> === PAUSE TestGlobMatch/foo_bar1560niks3-go-unit-tests> === CONT TestValidateToken_BoundClaimsMismatch1561niks3-go-unit-tests> === CONT TestValidateToken_MultipleProviders1562niks3-go-unit-tests> === CONT TestValidateToken_Expired1563niks3-go-unit-tests> === RUN TestGlobMatch/*_1564niks3-go-unit-tests> === PAUSE TestGlobMatch/*_1565niks3-go-unit-tests> === CONT TestValidateToken_WrongAudience1566niks3-go-unit-tests> === RUN TestGlobMatch/*_anything1567niks3-go-unit-tests> === PAUSE TestGlobMatch/*_anything1568niks3-go-unit-tests> === RUN TestGlobMatch/foo*_foo1569niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*_foo1570niks3-go-unit-tests> === RUN TestGlobMatch/foo*_foobar1571niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*_foobar1572niks3-go-unit-tests> === RUN TestGlobMatch/foo*_bar1573niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*_bar1574niks3-go-unit-tests> === RUN TestGlobMatch/*bar_bar1575niks3-go-unit-tests> === PAUSE TestGlobMatch/*bar_bar1576niks3-go-unit-tests> === RUN TestGlobMatch/*bar_foobar1577niks3-go-unit-tests> === CONT TestValidateToken_ValidToken1578niks3-go-unit-tests> === CONT TestAudienceForIssuer1579niks3-go-unit-tests> === CONT TestValidateToken_NoMatchingProvider1580niks3-go-unit-tests> --- PASS: TestAudienceForIssuer (0.00s)1581niks3-go-unit-tests> === CONT TestValidateToken_BoundSubjectMismatch1582niks3-go-unit-tests> === PAUSE TestGlobMatch/*bar_foobar1583niks3-go-unit-tests> === RUN TestGlobMatch/*bar_foo1584niks3-go-unit-tests> === PAUSE TestGlobMatch/*bar_foo1585niks3-go-unit-tests> === RUN TestGlobMatch/foo*bar_foobar1586niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*bar_foobar1587niks3-go-unit-tests> === RUN TestGlobMatch/foo*bar_foo123bar1588niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*bar_foo123bar1589niks3-go-unit-tests> === RUN TestGlobMatch/foo*bar_foobarbaz1590niks3-go-unit-tests> === PAUSE TestGlobMatch/foo*bar_foobarbaz1591niks3-go-unit-tests> === RUN TestGlobMatch/*/*_foo/bar1592niks3-go-unit-tests> === PAUSE TestGlobMatch/*/*_foo/bar1593niks3-go-unit-tests> === RUN TestGlobMatch/*/*_foo1594niks3-go-unit-tests> === PAUSE TestGlobMatch/*/*_foo1595niks3-go-unit-tests> === RUN TestGlobMatch/refs/heads/*_refs/heads/main1596niks3-go-unit-tests> === PAUSE TestGlobMatch/refs/heads/*_refs/heads/main1597niks3-go-unit-tests> === RUN TestGlobMatch/refs/heads/*_refs/tags/v1.01598niks3-go-unit-tests> === PAUSE TestGlobMatch/refs/heads/*_refs/tags/v1.01599niks3-go-unit-tests> === RUN TestGlobMatch/refs/*/main_refs/heads/main1600niks3-go-unit-tests> === PAUSE TestGlobMatch/refs/*/main_refs/heads/main1601niks3-go-unit-tests> === RUN TestGlobMatch/fo?_foo1602niks3-go-unit-tests> === PAUSE TestGlobMatch/fo?_foo1603niks3-go-unit-tests> === RUN TestGlobMatch/fo?_fo1604niks3-go-unit-tests> === PAUSE TestGlobMatch/fo?_fo1605niks3-go-unit-tests> === RUN TestGlobMatch/fo?_fooo1606niks3-go-unit-tests> === PAUSE TestGlobMatch/fo?_fooo1607niks3-go-unit-tests> === RUN TestGlobMatch/?oo_foo1608niks3-go-unit-tests> === PAUSE TestGlobMatch/?oo_foo1609niks3-go-unit-tests> === RUN TestGlobMatch/?oo_boo1610niks3-go-unit-tests> === PAUSE TestGlobMatch/?oo_boo1611niks3-go-unit-tests> === RUN TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main1612niks3-go-unit-tests> === PAUSE TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main1613niks3-go-unit-tests> === RUN TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main1614niks3-go-unit-tests> === PAUSE TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main1615niks3-go-unit-tests> === CONT TestGlobMatch/foo_foo1616niks3-go-unit-tests> === CONT TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main1617niks3-go-unit-tests> === CONT TestGlobMatch/refs/*/main_refs/heads/main1618niks3-go-unit-tests> === CONT TestGlobMatch/*_anything1619niks3-go-unit-tests> === CONT TestGlobMatch/?oo_boo1620niks3-go-unit-tests> === CONT TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main1621niks3-go-unit-tests> === CONT TestGlobMatch/?oo_foo1622niks3-go-unit-tests> === CONT TestGlobMatch/*/*_foo/bar1623niks3-go-unit-tests> === CONT TestGlobMatch/fo?_fo1624niks3-go-unit-tests> === CONT TestGlobMatch/fo?_foo1625niks3-go-unit-tests> === CONT TestGlobMatch/foo*bar_foobarbaz1626niks3-go-unit-tests> === CONT TestGlobMatch/foo*bar_foo123bar1627niks3-go-unit-tests> === CONT TestGlobMatch/foo*bar_foobar1628niks3-go-unit-tests> === CONT TestGlobMatch/*bar_foo1629niks3-go-unit-tests> === CONT TestGlobMatch/*bar_foobar1630niks3-go-unit-tests> === CONT TestGlobMatch/*bar_bar1631niks3-go-unit-tests> === CONT TestGlobMatch/foo*_bar1632niks3-go-unit-tests> === CONT TestGlobMatch/foo*_foobar1633niks3-go-unit-tests> === CONT TestGlobMatch/foo*_foo1634niks3-go-unit-tests> === CONT TestGlobMatch/refs/heads/*_refs/heads/main1635niks3-go-unit-tests> === CONT TestGlobMatch/fo?_fooo1636niks3-go-unit-tests> === CONT TestGlobMatch/refs/heads/*_refs/tags/v1.01637niks3-go-unit-tests> === CONT TestGlobMatch/foo_bar1638niks3-go-unit-tests> === CONT TestGlobMatch/*_1639niks3-go-unit-tests> === CONT TestGlobMatch/*/*_foo1640niks3-go-unit-tests> --- PASS: TestGlobMatch (0.00s)1641niks3-go-unit-tests> --- PASS: TestGlobMatch/foo_foo (0.00s)1642niks3-go-unit-tests> --- PASS: TestGlobMatch/repo:myorg/*:*_repo:myorg/myrepo:ref:refs/heads/main (0.00s)1643niks3-go-unit-tests> --- PASS: TestGlobMatch/*_anything (0.00s)1644niks3-go-unit-tests> --- PASS: TestGlobMatch/refs/*/main_refs/heads/main (0.00s)1645niks3-go-unit-tests> --- PASS: TestGlobMatch/?oo_boo (0.00s)1646niks3-go-unit-tests> --- PASS: TestGlobMatch/repo:myorg/*:*_repo:otherorg/myrepo:ref:refs/heads/main (0.00s)1647niks3-go-unit-tests> --- PASS: TestGlobMatch/?oo_foo (0.00s)1648niks3-go-unit-tests> --- PASS: TestGlobMatch/*/*_foo/bar (0.00s)1649niks3-go-unit-tests> --- PASS: TestGlobMatch/fo?_fo (0.00s)1650niks3-go-unit-tests> --- PASS: TestGlobMatch/fo?_foo (0.00s)1651niks3-go-unit-tests> --- PASS: TestGlobMatch/foo*bar_foobarbaz (0.00s)1652niks3-go-unit-tests> --- PASS: TestGlobMatch/foo*bar_foo123bar (0.00s)1653niks3-go-unit-tests> --- PASS: TestGlobMatch/foo*bar_foobar (0.00s)1654niks3-go-unit-tests> --- PASS: TestGlobMatch/*bar_foo (0.00s)1655niks3-go-unit-tests> --- PASS: TestGlobMatch/*bar_foobar (0.00s)1656niks3-go-unit-tests> --- PASS: TestGlobMatch/*bar_bar (0.00s)1657niks3-go-unit-tests> --- PASS: TestGlobMatch/foo*_bar (0.00s)1658niks3-go-unit-tests> --- PASS: TestGlobMatch/foo*_foobar (0.00s)1659niks3-go-unit-tests> --- PASS: TestGlobMatch/foo*_foo (0.00s)1660niks3-go-unit-tests> --- PASS: TestGlobMatch/refs/heads/*_refs/heads/main (0.00s)1661niks3-go-unit-tests> --- PASS: TestGlobMatch/fo?_fooo (0.00s)1662niks3-go-unit-tests> --- PASS: TestGlobMatch/refs/heads/*_refs/tags/v1.0 (0.00s)1663niks3-go-unit-tests> --- PASS: TestGlobMatch/foo_bar (0.00s)1664niks3-go-unit-tests> --- PASS: TestGlobMatch/*_ (0.00s)1665niks3-go-unit-tests> --- PASS: TestGlobMatch/*/*_foo (0.00s)1666niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=test1667niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=test1668niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=test1669niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=provider11670niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=test1671niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=provider11672niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=test1673niks3-go-unit-tests> 2026/06/28 09:21:32 INFO OIDC provider initialized name=provider21674niks3-go-unit-tests> --- PASS: TestValidateToken_BoundSubjectMismatch (0.01s)1675niks3-go-unit-tests> --- PASS: TestValidateToken_NoMatchingProvider (0.01s)1676niks3-go-unit-tests> --- PASS: TestValidateToken_ValidToken (0.01s)1677niks3-go-unit-tests> --- PASS: TestValidateToken_BoundClaimsMismatch (0.01s)1678niks3-go-unit-tests> --- PASS: TestValidateToken_Expired (0.01s)1679niks3-go-unit-tests> --- PASS: TestValidateToken_WrongAudience (0.01s)1680niks3-go-unit-tests> --- PASS: TestValidateToken_MultipleProviders (0.01s)1681niks3-go-unit-tests> PASS1682niks3-go-unit-tests> Running hook tests...1683niks3-go-unit-tests> === RUN TestSendPathsEmpty1684niks3-go-unit-tests> === PAUSE TestSendPathsEmpty1685niks3-go-unit-tests> === RUN TestQueueEnqueueAndFetch1686niks3-go-unit-tests> === PAUSE TestQueueEnqueueAndFetch1687niks3-go-unit-tests> === RUN TestQueueDeduplication1688niks3-go-unit-tests> === PAUSE TestQueueDeduplication1689niks3-go-unit-tests> === RUN TestQueueRemove1690niks3-go-unit-tests> === PAUSE TestQueueRemove1691niks3-go-unit-tests> === RUN TestQueueFetchBatchLimit1692niks3-go-unit-tests> === PAUSE TestQueueFetchBatchLimit1693niks3-go-unit-tests> === RUN TestQueueFetchRemoveLifecycle1694niks3-go-unit-tests> === PAUSE TestQueueFetchRemoveLifecycle1695niks3-go-unit-tests> === RUN TestQueueConcurrentWriters1696niks3-go-unit-tests> === PAUSE TestQueueConcurrentWriters1697niks3-go-unit-tests> === RUN TestServerClientIntegration1698niks3-go-unit-tests> === PAUSE TestServerClientIntegration1699niks3-go-unit-tests> === RUN TestServerQueueError1700niks3-go-unit-tests> === PAUSE TestServerQueueError1701niks3-go-unit-tests> === RUN TestGetListenerSocketActivation1702niks3-go-unit-tests> server_test.go:210: === RUN TestGetListenerSocketActivation1703niks3-go-unit-tests> --- PASS: TestGetListenerSocketActivation (0.00s)1704niks3-go-unit-tests> PASS1705niks3-go-unit-tests> 1706niks3-go-unit-tests> --- PASS: TestGetListenerSocketActivation (0.03s)1707niks3-go-unit-tests> === RUN TestWorkerUploadsAndRemoves1708niks3-go-unit-tests> === PAUSE TestWorkerUploadsAndRemoves1709niks3-go-unit-tests> === RUN TestWorkerSkipsGCdPaths1710niks3-go-unit-tests> === PAUSE TestWorkerSkipsGCdPaths1711niks3-go-unit-tests> === RUN TestWorkerPrunesClosureDeps1712niks3-go-unit-tests> === PAUSE TestWorkerPrunesClosureDeps1713niks3-go-unit-tests> === CONT TestSendPathsEmpty1714niks3-go-unit-tests> --- PASS: TestSendPathsEmpty (0.00s)1715niks3-go-unit-tests> === CONT TestWorkerPrunesClosureDeps1716niks3-go-unit-tests> === CONT TestQueueConcurrentWriters1717niks3-go-unit-tests> === CONT TestQueueDeduplication1718niks3-go-unit-tests> === CONT TestWorkerUploadsAndRemoves1719niks3-go-unit-tests> === CONT TestWorkerSkipsGCdPaths1720niks3-go-unit-tests> === CONT TestQueueFetchRemoveLifecycle1721niks3-go-unit-tests> === CONT TestQueueRemove1722niks3-go-unit-tests> === CONT TestServerQueueError1723niks3-go-unit-tests> === CONT TestQueueFetchBatchLimit1724niks3-go-unit-tests> === CONT TestQueueEnqueueAndFetch1725niks3-go-unit-tests> === CONT TestServerClientIntegration1726niks3-go-unit-tests> 2026/06/28 09:21:32 ERROR Failed to queue paths error="permission denied" count=11727niks3-go-unit-tests> --- PASS: TestServerQueueError (0.00s)1728niks3-go-unit-tests> --- PASS: TestServerClientIntegration (0.00s)1729niks3-go-unit-tests> 2026/06/28 09:21:32 INFO Upload queue status pending=21730niks3-go-unit-tests> 2026/06/28 09:21:32 INFO Uploading batch count=21731niks3-go-unit-tests> --- PASS: TestQueueFetchBatchLimit (0.01s)1732niks3-go-unit-tests> --- PASS: TestQueueFetchRemoveLifecycle (0.02s)1733niks3-go-unit-tests> 2026/06/28 09:21:32 INFO Upload queue status pending=21734niks3-go-unit-tests> --- PASS: TestQueueEnqueueAndFetch (0.02s)1735niks3-go-unit-tests> 2026/06/28 09:21:32 WARN Store path no longer exists (garbage collected?), removing from queue path=/build/TestWorkerSkipsGCdPaths1857932180/002/nonexistent1736niks3-go-unit-tests> --- PASS: TestQueueDeduplication (0.02s)1737niks3-go-unit-tests> 2026/06/28 09:21:32 INFO Upload queue status pending=21738niks3-go-unit-tests> 2026/06/28 09:21:32 INFO Uploading batch count=11739niks3-go-unit-tests> --- PASS: TestQueueRemove (0.02s)1740niks3-go-unit-tests> 2026/06/28 09:21:32 INFO Uploading batch count=11741niks3-go-unit-tests> --- PASS: TestWorkerPrunesClosureDeps (0.06s)1742niks3-go-unit-tests> --- PASS: TestWorkerUploadsAndRemoves (0.06s)1743niks3-go-unit-tests> --- PASS: TestWorkerSkipsGCdPaths (0.07s)1744niks3-go-unit-tests> --- PASS: TestQueueConcurrentWriters (0.20s)1745niks3-go-unit-tests> PASS17461747post-build step Upload coverage to codecov: ok1748Skipping codecov: project=Mic92/niks3 attr=x86_64-linux.go-unit-tests