this derivation will be built:
  /nix/store/zdnm5gns1bd6r7kksx91agc1alz6dq01-niks3-go-unit-tests.drv
building '/nix/store/zdnm5gns1bd6r7kksx91agc1alz6dq01-niks3-go-unit-tests.drv' on 'ssh-ng://customer@mac02'
building '/nix/store/zdnm5gns1bd6r7kksx91agc1alz6dq01-niks3-go-unit-tests.drv'
niks3-go-unit-tests> Running client tests...
niks3-go-unit-tests> === RUN   TestDoServerRequestAttachesToken
niks3-go-unit-tests> === PAUSE TestDoServerRequestAttachesToken
niks3-go-unit-tests> === RUN   TestCaseHackSuffix
niks3-go-unit-tests> === PAUSE TestCaseHackSuffix
niks3-go-unit-tests> === RUN   TestPartSizeForNAR
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR
niks3-go-unit-tests> === RUN   TestDumpPathMatchesNix
niks3-go-unit-tests> === PAUSE TestDumpPathMatchesNix
niks3-go-unit-tests> === RUN   TestDumpPathSingleFile
niks3-go-unit-tests> === PAUSE TestDumpPathSingleFile
niks3-go-unit-tests> === RUN   TestDumpPathWriterError
niks3-go-unit-tests> === PAUSE TestDumpPathWriterError
niks3-go-unit-tests> === RUN   TestEncodeNixBase32
niks3-go-unit-tests> === PAUSE TestEncodeNixBase32
niks3-go-unit-tests> === RUN   TestEncodeNixBase32WithRealHash
niks3-go-unit-tests> === PAUSE TestEncodeNixBase32WithRealHash
niks3-go-unit-tests> === RUN   TestConvertHashToNix32
niks3-go-unit-tests> === PAUSE TestConvertHashToNix32
niks3-go-unit-tests> === RUN   TestGetStorePathHash
niks3-go-unit-tests> === PAUSE TestGetStorePathHash
niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility
niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility
niks3-go-unit-tests> === RUN   TestParsePathInfoJSON
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON
niks3-go-unit-tests> === RUN   TestParsePathInfoJSONMultiplePaths
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths
niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility
niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility
niks3-go-unit-tests> === RUN   TestRateLimiterFeedback
niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback
niks3-go-unit-tests> === RUN   TestRateLimiterFeedback_400DoesNotCountAsSuccess
niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback_400DoesNotCountAsSuccess
niks3-go-unit-tests> === RUN   TestDoWithRetry_BodyReplayedViaGetBody
niks3-go-unit-tests> === PAUSE TestDoWithRetry_BodyReplayedViaGetBody
niks3-go-unit-tests> === RUN   TestShellSplit
niks3-go-unit-tests> === PAUSE TestShellSplit
niks3-go-unit-tests> === RUN   TestShellSplitErrors
niks3-go-unit-tests> === PAUSE TestShellSplitErrors
niks3-go-unit-tests> === RUN   TestSetClientTLS
niks3-go-unit-tests> === PAUSE TestSetClientTLS
niks3-go-unit-tests> === RUN   TestSetClientTLSDoesNotMutateDefaultTransport
niks3-go-unit-tests> === PAUSE TestSetClientTLSDoesNotMutateDefaultTransport
niks3-go-unit-tests> === RUN   TestSetClientTLSErrors
niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors
niks3-go-unit-tests> === RUN   TestStaticToken
niks3-go-unit-tests> === PAUSE TestStaticToken
niks3-go-unit-tests> === RUN   TestFileTokenReadsAndCaches
niks3-go-unit-tests> === PAUSE TestFileTokenReadsAndCaches
niks3-go-unit-tests> === RUN   TestFileTokenMissing
niks3-go-unit-tests> === PAUSE TestFileTokenMissing
niks3-go-unit-tests> === RUN   TestFileTokenEmpty
niks3-go-unit-tests> === PAUSE TestFileTokenEmpty
niks3-go-unit-tests> === RUN   TestScriptTokenNoExpiryRerunsEveryCall
niks3-go-unit-tests> === PAUSE TestScriptTokenNoExpiryRerunsEveryCall
niks3-go-unit-tests> === RUN   TestScriptTokenCachesUntilRefresh
niks3-go-unit-tests> === PAUSE TestScriptTokenCachesUntilRefresh
niks3-go-unit-tests> === RUN   TestScriptTokenEmptyToken
niks3-go-unit-tests> === PAUSE TestScriptTokenEmptyToken
niks3-go-unit-tests> === RUN   TestScriptTokenBadJSON
niks3-go-unit-tests> === PAUSE TestScriptTokenBadJSON
niks3-go-unit-tests> === RUN   TestScriptTokenScriptFails
niks3-go-unit-tests> === PAUSE TestScriptTokenScriptFails
niks3-go-unit-tests> === RUN   TestScriptTokenEmptyCommand
niks3-go-unit-tests> === PAUSE TestScriptTokenEmptyCommand
niks3-go-unit-tests> === CONT  TestDoServerRequestAttachesToken
niks3-go-unit-tests> === CONT  TestFileTokenMissing
niks3-go-unit-tests> === CONT  TestDoWithRetry_BodyReplayedViaGetBody
niks3-go-unit-tests> === CONT  TestFileTokenReadsAndCaches
niks3-go-unit-tests> === CONT  TestConvertHashToNix32
niks3-go-unit-tests> === CONT  TestSetClientTLSDoesNotMutateDefaultTransport
niks3-go-unit-tests> === RUN   TestConvertHashToNix32/SRI_format_to_Nix32
niks3-go-unit-tests> === CONT  TestParsePathInfoJSONMultiplePaths
niks3-go-unit-tests> === RUN   TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths
niks3-go-unit-tests> === RUN   TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths
niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/SRI_format_to_Nix32
niks3-go-unit-tests> === RUN   TestConvertHashToNix32/already_Nix32_format
niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/already_Nix32_format
niks3-go-unit-tests> === RUN   TestConvertHashToNix32/invalid_format
niks3-go-unit-tests> === PAUSE TestConvertHashToNix32/invalid_format
niks3-go-unit-tests> === CONT  TestRateLimiterFeedback
niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/429_enables_limiter
niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/429_enables_limiter
niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/503_enables_limiter
niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/503_enables_limiter
niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/200_does_not_enable_limiter
niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/200_does_not_enable_limiter
niks3-go-unit-tests> === RUN   TestRateLimiterFeedback/400_does_not_enable_limiter
niks3-go-unit-tests> === PAUSE TestRateLimiterFeedback/400_does_not_enable_limiter
niks3-go-unit-tests> === CONT  TestParsePathInfoJSON
niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/Nix_format
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/Nix_format
niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/Lix_format
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/Lix_format
niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/empty_input
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/empty_input
niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/whitespace_only
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/whitespace_only
niks3-go-unit-tests> === RUN   TestParsePathInfoJSON/invalid_JSON
niks3-go-unit-tests> === PAUSE TestParsePathInfoJSON/invalid_JSON
niks3-go-unit-tests> === CONT  TestRateLimiterFeedback_400DoesNotCountAsSuccess
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Rate limiter enabled after throttle name=server-test rate=5
niks3-go-unit-tests> === CONT  TestScriptTokenEmptyToken
niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility
niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)
niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)
niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/old_string_format_with_colon
niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/old_string_format_with_colon
niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI
niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI
niks3-go-unit-tests> === RUN   TestPathInfoHashCompatibility/new_structured_format_with_sha512
niks3-go-unit-tests> === PAUSE TestPathInfoHashCompatibility/new_structured_format_with_sha512
niks3-go-unit-tests> === CONT  TestGetStorePathHash
niks3-go-unit-tests> === RUN   TestGetStorePathHash/valid_store_path
niks3-go-unit-tests> === PAUSE TestGetStorePathHash/valid_store_path
niks3-go-unit-tests> === RUN   TestGetStorePathHash/basename_without_hyphen_should_error
niks3-go-unit-tests> === PAUSE TestGetStorePathHash/basename_without_hyphen_should_error
niks3-go-unit-tests> === RUN   TestGetStorePathHash/hash_with_invalid_characters_should_error
niks3-go-unit-tests> === CONT  TestDumpPathSingleFile
niks3-go-unit-tests> === CONT  TestScriptTokenScriptFails
niks3-go-unit-tests> --- PASS: TestFileTokenReadsAndCaches (0.00s)
niks3-go-unit-tests> --- PASS: TestFileTokenMissing (0.00s)
niks3-go-unit-tests> === PAUSE TestGetStorePathHash/hash_with_invalid_characters_should_error
niks3-go-unit-tests> === CONT  TestScriptTokenEmptyCommand
niks3-go-unit-tests> --- PASS: TestScriptTokenEmptyCommand (0.00s)
niks3-go-unit-tests> === CONT  TestEncodeNixBase32WithRealHash
niks3-go-unit-tests> === RUN   TestGetStorePathHash/hash_with_wrong_length_should_error
niks3-go-unit-tests> --- PASS: TestEncodeNixBase32WithRealHash (0.00s)
niks3-go-unit-tests> === CONT  TestEncodeNixBase32
niks3-go-unit-tests> === RUN   TestEncodeNixBase32/test_string_hash
niks3-go-unit-tests> === CONT  TestScriptTokenBadJSON
niks3-go-unit-tests> === PAUSE TestEncodeNixBase32/test_string_hash
niks3-go-unit-tests> === RUN   TestEncodeNixBase32/empty_input
niks3-go-unit-tests> === PAUSE TestEncodeNixBase32/empty_input
niks3-go-unit-tests> === CONT  TestDumpPathWriterError
niks3-go-unit-tests> === PAUSE TestGetStorePathHash/hash_with_wrong_length_should_error
niks3-go-unit-tests> === CONT  TestShellSplitErrors
niks3-go-unit-tests> --- PASS: TestShellSplitErrors (0.00s)
niks3-go-unit-tests> === CONT  TestSetClientTLS
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Rate limiter enabled after throttle name=server-test rate=5
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Request returned retryable status, retrying attempt=1 max_attempts=6 backoff=0s status=503 url=http://127.0.0.1:52113
niks3-go-unit-tests> --- PASS: TestDoServerRequestAttachesToken (0.00s)
niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility
niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/null_ca_field
niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/null_ca_field
niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/old_string_format_-_text
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Rate limiter backed off name=server-test rate=5
niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/old_string_format_-_text
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Request returned retryable status, retrying attempt=2 max_attempts=6 backoff=0s status=503 url=http://127.0.0.1:52113
niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/old_string_format_-_fixed_recursive
niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/old_string_format_-_fixed_recursive
niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/new_structured_format_-_text
niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/new_structured_format_-_text
niks3-go-unit-tests> === RUN   TestPathInfoCACompatibility/new_structured_format_-_nar_method
niks3-go-unit-tests> === PAUSE TestPathInfoCACompatibility/new_structured_format_-_nar_method
niks3-go-unit-tests> --- PASS: TestSetClientTLSDoesNotMutateDefaultTransport (0.01s)
niks3-go-unit-tests> === CONT  TestPartSizeForNAR
niks3-go-unit-tests> === CONT  TestShellSplit
niks3-go-unit-tests> === RUN   TestPartSizeForNAR/zero_stays_at_minimum
niks3-go-unit-tests> --- PASS: TestShellSplit (0.00s)
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/zero_stays_at_minimum
niks3-go-unit-tests> === RUN   TestPartSizeForNAR/small_stays_at_minimum
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/small_stays_at_minimum
niks3-go-unit-tests> === CONT  TestDumpPathMatchesNix
niks3-go-unit-tests> === RUN   TestPartSizeForNAR/80_GiB_fits_at_minimum
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/80_GiB_fits_at_minimum
niks3-go-unit-tests> === RUN   TestPartSizeForNAR/115_GiB_needs_larger_parts
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/115_GiB_needs_larger_parts
niks3-go-unit-tests> === RUN   TestPartSizeForNAR/1_TiB
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/1_TiB
niks3-go-unit-tests> === RUN   TestPartSizeForNAR/5_TiB_S3_max_object
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/5_TiB_S3_max_object
niks3-go-unit-tests> === RUN   TestPartSizeForNAR/capped_at_5_GiB
niks3-go-unit-tests> === PAUSE TestPartSizeForNAR/capped_at_5_GiB
niks3-go-unit-tests> === CONT  TestScriptTokenNoExpiryRerunsEveryCall
niks3-go-unit-tests> --- PASS: TestDoWithRetry_BodyReplayedViaGetBody (0.01s)
niks3-go-unit-tests> === CONT  TestScriptTokenCachesUntilRefresh
niks3-go-unit-tests> --- PASS: TestScriptTokenScriptFails (0.01s)
niks3-go-unit-tests> === CONT  TestFileTokenEmpty
niks3-go-unit-tests> === RUN   TestSetClientTLS/rejects_connection_without_client_cert
niks3-go-unit-tests> === PAUSE TestSetClientTLS/rejects_connection_without_client_cert
niks3-go-unit-tests> === CONT  TestStaticToken
niks3-go-unit-tests> === CONT  TestSetClientTLSErrors
niks3-go-unit-tests> === RUN   TestSetClientTLS/succeeds_with_client_cert_and_CA
niks3-go-unit-tests> --- PASS: TestFileTokenEmpty (0.00s)
niks3-go-unit-tests> --- PASS: TestStaticToken (0.00s)
niks3-go-unit-tests> === PAUSE TestSetClientTLS/succeeds_with_client_cert_and_CA
niks3-go-unit-tests> === RUN   TestSetClientTLS/preserves_debug_logging_transport
niks3-go-unit-tests> === PAUSE TestSetClientTLS/preserves_debug_logging_transport
niks3-go-unit-tests> === CONT  TestCaseHackSuffix
niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/missing_cert_file
niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_cert_file
niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/missing_key_file
niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_key_file
niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/missing_ca_file
niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/missing_ca_file
niks3-go-unit-tests> === RUN   TestSetClientTLSErrors/invalid_ca_file
niks3-go-unit-tests> === PAUSE TestSetClientTLSErrors/invalid_ca_file
niks3-go-unit-tests> === CONT  TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths
niks3-go-unit-tests> === CONT  TestConvertHashToNix32/SRI_format_to_Nix32
niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/429_enables_limiter
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Rate limiter enabled after throttle name=server-test rate=5
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Request returned retryable status, retrying attempt=1 max_attempts=2 backoff=0s status=429 url=http://127.0.0.1:52119
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Rate limiter backed off name=server-test rate=5
niks3-go-unit-tests> === CONT  TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths
niks3-go-unit-tests> --- PASS: TestParsePathInfoJSONMultiplePaths (0.00s)
niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths (0.00s)
niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths (0.00s)
niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/Nix_format
niks3-go-unit-tests> === CONT  TestConvertHashToNix32/invalid_format
niks3-go-unit-tests> === CONT  TestConvertHashToNix32/already_Nix32_format
niks3-go-unit-tests> --- PASS: TestConvertHashToNix32 (0.00s)
niks3-go-unit-tests>     --- PASS: TestConvertHashToNix32/SRI_format_to_Nix32 (0.00s)
niks3-go-unit-tests>     --- PASS: TestConvertHashToNix32/invalid_format (0.00s)
niks3-go-unit-tests>     --- PASS: TestConvertHashToNix32/already_Nix32_format (0.00s)
niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/400_does_not_enable_limiter
niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/200_does_not_enable_limiter
niks3-go-unit-tests> === CONT  TestRateLimiterFeedback/503_enables_limiter
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Rate limiter enabled after throttle name=server-test rate=5
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Request returned retryable status, retrying attempt=1 max_attempts=2 backoff=0s status=503 url=http://127.0.0.1:52125
niks3-go-unit-tests> --- PASS: TestScriptTokenEmptyToken (0.01s)
niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)
niks3-go-unit-tests> 2026/06/08 09:35:16 WARN Rate limiter backed off name=server-test rate=5
niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/new_structured_format_with_sha512
niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback (0.00s)
niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/429_enables_limiter (0.00s)
niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/400_does_not_enable_limiter (0.00s)
niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/200_does_not_enable_limiter (0.00s)
niks3-go-unit-tests>     --- PASS: TestRateLimiterFeedback/503_enables_limiter (0.00s)
niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI
niks3-go-unit-tests> --- PASS: TestScriptTokenBadJSON (0.01s)
niks3-go-unit-tests> === CONT  TestPathInfoHashCompatibility/old_string_format_with_colon
niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/empty_input
niks3-go-unit-tests> --- PASS: TestPathInfoHashCompatibility (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI) (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/new_structured_format_with_sha512 (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoHashCompatibility/old_string_format_with_colon (0.00s)
niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/invalid_JSON
niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/Lix_format
niks3-go-unit-tests> === CONT  TestEncodeNixBase32/test_string_hash
niks3-go-unit-tests> === CONT  TestParsePathInfoJSON/whitespace_only
niks3-go-unit-tests> --- PASS: TestParsePathInfoJSON (0.00s)
niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/Nix_format (0.00s)
niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/empty_input (0.00s)
niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/invalid_JSON (0.00s)
niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/Lix_format (0.00s)
niks3-go-unit-tests>     --- PASS: TestParsePathInfoJSON/whitespace_only (0.00s)
niks3-go-unit-tests> === CONT  TestGetStorePathHash/hash_with_wrong_length_should_error
niks3-go-unit-tests> === CONT  TestEncodeNixBase32/empty_input
niks3-go-unit-tests> === CONT  TestGetStorePathHash/basename_without_hyphen_should_error
niks3-go-unit-tests> === CONT  TestGetStorePathHash/valid_store_path
niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/null_ca_field
niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/new_structured_format_-_nar_method
niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/new_structured_format_-_text
niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/old_string_format_-_fixed_recursive
niks3-go-unit-tests> === CONT  TestPathInfoCACompatibility/old_string_format_-_text
niks3-go-unit-tests> === CONT  TestPartSizeForNAR/zero_stays_at_minimum
niks3-go-unit-tests> === CONT  TestPartSizeForNAR/capped_at_5_GiB
niks3-go-unit-tests> --- PASS: TestEncodeNixBase32 (0.00s)
niks3-go-unit-tests>     --- PASS: TestEncodeNixBase32/test_string_hash (0.00s)
niks3-go-unit-tests>     --- PASS: TestEncodeNixBase32/empty_input (0.00s)
niks3-go-unit-tests> === CONT  TestGetStorePathHash/hash_with_invalid_characters_should_error
niks3-go-unit-tests> --- PASS: TestGetStorePathHash (0.00s)
niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/hash_with_wrong_length_should_error (0.00s)
niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/basename_without_hyphen_should_error (0.00s)
niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/valid_store_path (0.00s)
niks3-go-unit-tests>     --- PASS: TestGetStorePathHash/hash_with_invalid_characters_should_error (0.00s)
niks3-go-unit-tests> === CONT  TestPartSizeForNAR/5_TiB_S3_max_object
niks3-go-unit-tests> --- PASS: TestPathInfoCACompatibility (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/null_ca_field (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/new_structured_format_-_nar_method (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/old_string_format_-_fixed_recursive (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/old_string_format_-_text (0.00s)
niks3-go-unit-tests>     --- PASS: TestPathInfoCACompatibility/new_structured_format_-_text (0.00s)
niks3-go-unit-tests> === CONT  TestPartSizeForNAR/1_TiB
niks3-go-unit-tests> === CONT  TestPartSizeForNAR/115_GiB_needs_larger_parts
niks3-go-unit-tests> === CONT  TestPartSizeForNAR/small_stays_at_minimum
niks3-go-unit-tests> === CONT  TestSetClientTLS/preserves_debug_logging_transport
niks3-go-unit-tests> === CONT  TestSetClientTLS/rejects_connection_without_client_cert
niks3-go-unit-tests> === CONT  TestPartSizeForNAR/80_GiB_fits_at_minimum
niks3-go-unit-tests> --- PASS: TestPartSizeForNAR (0.00s)
niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/zero_stays_at_minimum (0.00s)
niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/capped_at_5_GiB (0.00s)
niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/5_TiB_S3_max_object (0.00s)
niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/1_TiB (0.00s)
niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/115_GiB_needs_larger_parts (0.00s)
niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/small_stays_at_minimum (0.00s)
niks3-go-unit-tests>     --- PASS: TestPartSizeForNAR/80_GiB_fits_at_minimum (0.00s)
niks3-go-unit-tests> === CONT  TestSetClientTLS/succeeds_with_client_cert_and_CA
niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/missing_cert_file
niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/missing_ca_file
niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/invalid_ca_file
niks3-go-unit-tests> === CONT  TestSetClientTLSErrors/missing_key_file
niks3-go-unit-tests> --- PASS: TestSetClientTLSErrors (0.00s)
niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/missing_cert_file (0.00s)
niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/missing_ca_file (0.00s)
niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/missing_key_file (0.00s)
niks3-go-unit-tests>     --- PASS: TestSetClientTLSErrors/invalid_ca_file (0.00s)
niks3-go-unit-tests> 2026/06/08 09:35:16 http: TLS handshake error from 127.0.0.1:52127: read tcp 127.0.0.1:52118->127.0.0.1:52127: use of closed network connection
niks3-go-unit-tests> --- PASS: TestSetClientTLS (0.01s)
niks3-go-unit-tests>     --- PASS: TestSetClientTLS/preserves_debug_logging_transport (0.00s)
niks3-go-unit-tests>     --- PASS: TestSetClientTLS/succeeds_with_client_cert_and_CA (0.00s)
niks3-go-unit-tests>     --- PASS: TestSetClientTLS/rejects_connection_without_client_cert (0.01s)
niks3-go-unit-tests> --- PASS: TestScriptTokenCachesUntilRefresh (0.03s)
niks3-go-unit-tests> --- PASS: TestScriptTokenNoExpiryRerunsEveryCall (0.03s)
niks3-go-unit-tests> --- PASS: TestDumpPathWriterError (0.05s)
niks3-go-unit-tests> --- PASS: TestRateLimiterFeedback_400DoesNotCountAsSuccess (1.00s)
niks3-go-unit-tests> --- PASS: TestDumpPathSingleFile (8.06s)
niks3-go-unit-tests> --- PASS: TestCaseHackSuffix (8.05s)
niks3-go-unit-tests> --- PASS: TestDumpPathMatchesNix (8.06s)
niks3-go-unit-tests> PASS
niks3-go-unit-tests> Running server tests...
niks3-go-unit-tests> The files belonging to this database system will be owned by user "_nixbld11".
niks3-go-unit-tests> This user must also own the server process.
niks3-go-unit-tests> 
niks3-go-unit-tests> The database cluster will be initialized with locale "C".
niks3-go-unit-tests> The default database encoding has accordingly been set to "SQL_ASCII".
niks3-go-unit-tests> The default text search configuration will be set to "english".
niks3-go-unit-tests> 
niks3-go-unit-tests> Data page checksums are disabled.
niks3-go-unit-tests> 
niks3-go-unit-tests> creating directory /nix/var/nix/builds/nix-43615-2689963028/postgres2494324006/data ... ok
niks3-go-unit-tests> creating subdirectories ... ok
niks3-go-unit-tests> selecting dynamic shared memory implementation ... posix
niks3-go-unit-tests> selecting default "max_connections" ... 100
niks3-go-unit-tests> selecting default "shared_buffers" ... 128MB
niks3-go-unit-tests> selecting default time zone ... UTC
niks3-go-unit-tests> creating configuration files ... ok
niks3-go-unit-tests> running bootstrap script ... ok
niks3-go-unit-tests> performing post-bootstrap initialization ... ok
niks3-go-unit-tests> syncing data to disk ... ok
niks3-go-unit-tests> 
niks3-go-unit-tests> initdb: warning: enabling "trust" authentication for local connections
niks3-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.
niks3-go-unit-tests> 
niks3-go-unit-tests> Success. You can now start the database server using:
niks3-go-unit-tests> 
niks3-go-unit-tests>     pg_ctl -D /nix/var/nix/builds/nix-43615-2689963028/postgres2494324006/data -l logfile start
niks3-go-unit-tests> 
niks3-go-unit-tests> 2026-06-08 09:35:27.033 UTC [44261] LOG:  starting PostgreSQL 17.10 on aarch64-apple-darwin25.4.0, compiled by clang version 21.1.8, 64-bit
niks3-go-unit-tests> 2026-06-08 09:35:27.033 UTC [44261] LOG:  listening on Unix socket "/nix/var/nix/builds/nix-43615-2689963028/postgres2494324006/.s.PGSQL.5432"
niks3-go-unit-tests> 2026-06-08 09:35:27.034 UTC [44265] LOG:  database system was shut down at 2026-06-08 09:35:27 UTC
niks3-go-unit-tests> 2026-06-08 09:35:27.036 UTC [44261] LOG:  database system is ready to accept connections
niks3-go-unit-tests> /nix/var/nix/builds/nix-43615-2689963028/postgres2494324006:5432 - accepting connections
niks3-go-unit-tests> RustFS API: http://49.12.162.61:52136  http://127.0.0.1:52136
niks3-go-unit-tests> RustFS Start Time: 2026-06-08 09:35:28
niks3-go-unit-tests> Console WebUI Start Time: 2026-06-08 09:35:28
niks3-go-unit-tests> Console WebUI available at: http://49.12.162.61:52137/rustfs/console/index.html
niks3-go-unit-tests> Console WebUI (localhost): http://127.0.0.1:52137/rustfs/console/index.html
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_MTLSProxyHeader
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_MTLSProxyHeader
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_MTLSBoundSubjects
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_MTLSBoundSubjects
niks3-go-unit-tests> === RUN   TestService_ReadAuthMiddleware
niks3-go-unit-tests> === PAUSE TestService_ReadAuthMiddleware
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC
niks3-go-unit-tests> === RUN   TestCacheConfigHandler
niks3-go-unit-tests> === PAUSE TestCacheConfigHandler
niks3-go-unit-tests> === RUN   TestClientCADerivations
niks3-go-unit-tests> === PAUSE TestClientCADerivations
niks3-go-unit-tests> === RUN   TestClientErrorHandling
niks3-go-unit-tests> === PAUSE TestClientErrorHandling
niks3-go-unit-tests> === RUN   TestClientIntegration
niks3-go-unit-tests> === PAUSE TestClientIntegration
niks3-go-unit-tests> === RUN   TestClientMultipleUploads
niks3-go-unit-tests> === PAUSE TestClientMultipleUploads
niks3-go-unit-tests> === RUN   TestClientWithDependencies
niks3-go-unit-tests> === PAUSE TestClientWithDependencies
niks3-go-unit-tests> === RUN   TestPinProtectsFromGC
niks3-go-unit-tests> === PAUSE TestPinProtectsFromGC
niks3-go-unit-tests> === RUN   TestGCBugBareHashReferences
niks3-go-unit-tests> === PAUSE TestGCBugBareHashReferences
niks3-go-unit-tests> === RUN   TestGCTaskStore_StartNew
niks3-go-unit-tests> === PAUSE TestGCTaskStore_StartNew
niks3-go-unit-tests> === RUN   TestGCTaskStore_DeduplicateSameParams
niks3-go-unit-tests> === PAUSE TestGCTaskStore_DeduplicateSameParams
niks3-go-unit-tests> === RUN   TestGCTaskStore_ConflictDifferentParams
niks3-go-unit-tests> === PAUSE TestGCTaskStore_ConflictDifferentParams
niks3-go-unit-tests> === RUN   TestGCTaskStore_GetEmpty
niks3-go-unit-tests> === PAUSE TestGCTaskStore_GetEmpty
niks3-go-unit-tests> === RUN   TestGCTaskStore_GetReturnsLatest
niks3-go-unit-tests> === PAUSE TestGCTaskStore_GetReturnsLatest
niks3-go-unit-tests> === RUN   TestGCTaskStore_CompletedAllowsNewTask
niks3-go-unit-tests> === PAUSE TestGCTaskStore_CompletedAllowsNewTask
niks3-go-unit-tests> === RUN   TestGCTaskStore_PhaseUpdates
niks3-go-unit-tests> === PAUSE TestGCTaskStore_PhaseUpdates
niks3-go-unit-tests> === RUN   TestGCTaskStore_Fail
niks3-go-unit-tests> === PAUSE TestGCTaskStore_Fail
niks3-go-unit-tests> === RUN   TestService_healthCheckHandler
niks3-go-unit-tests> === PAUSE TestService_healthCheckHandler
niks3-go-unit-tests> === RUN   TestGenerateLandingPage
niks3-go-unit-tests> === PAUSE TestGenerateLandingPage
niks3-go-unit-tests> === RUN   TestNARDeduplicationMetadataUploadBug
niks3-go-unit-tests> === PAUSE TestNARDeduplicationMetadataUploadBug
niks3-go-unit-tests> === RUN   TestService_NativeMTLS
niks3-go-unit-tests> === PAUSE TestService_NativeMTLS
niks3-go-unit-tests> === RUN   TestServerTLSConfig
niks3-go-unit-tests> === PAUSE TestServerTLSConfig
niks3-go-unit-tests> === RUN   TestMultipartCleanup
niks3-go-unit-tests> === PAUSE TestMultipartCleanup
niks3-go-unit-tests> === RUN   TestOrphanedObjectsGC
niks3-go-unit-tests> === PAUSE TestOrphanedObjectsGC
niks3-go-unit-tests> === RUN   TestOrphanedObjectsGCStressTest
niks3-go-unit-tests> === PAUSE TestOrphanedObjectsGCStressTest
niks3-go-unit-tests> === RUN   TestResurrectedObjectNotDeleted
niks3-go-unit-tests> === PAUSE TestResurrectedObjectNotDeleted
niks3-go-unit-tests> === RUN   TestParseSingleRange
niks3-go-unit-tests> === PAUSE TestParseSingleRange
niks3-go-unit-tests> === RUN   TestIsValidCachePath
niks3-go-unit-tests> === PAUSE TestIsValidCachePath
niks3-go-unit-tests> === RUN   TestReadProxyNarinfo
niks3-go-unit-tests> === PAUSE TestReadProxyNarinfo
niks3-go-unit-tests> === RUN   TestReadProxyNarinfoAlreadyDecompressed
niks3-go-unit-tests> === PAUSE TestReadProxyNarinfoAlreadyDecompressed
niks3-go-unit-tests> === RUN   TestReadProxyNarStreaming
niks3-go-unit-tests> === PAUSE TestReadProxyNarStreaming
niks3-go-unit-tests> === RUN   TestReadProxy404
niks3-go-unit-tests> === PAUSE TestReadProxy404
niks3-go-unit-tests> === RUN   TestReadProxyInvalidPath
niks3-go-unit-tests> === PAUSE TestReadProxyInvalidPath
niks3-go-unit-tests> === RUN   TestReadProxyHead
niks3-go-unit-tests> === PAUSE TestReadProxyHead
niks3-go-unit-tests> === RUN   TestReadProxyConditionalGet
niks3-go-unit-tests> === PAUSE TestReadProxyConditionalGet
niks3-go-unit-tests> === RUN   TestReadProxyRootRedirectsToIndexHTML
niks3-go-unit-tests> === PAUSE TestReadProxyRootRedirectsToIndexHTML
niks3-go-unit-tests> === RUN   TestReadProxyDisabled
niks3-go-unit-tests> === PAUSE TestReadProxyDisabled
niks3-go-unit-tests> === RUN   TestReadProxyRangeRequest
niks3-go-unit-tests> === PAUSE TestReadProxyRangeRequest
niks3-go-unit-tests> === RUN   TestService_Rustfstest
niks3-go-unit-tests> === PAUSE TestService_Rustfstest
niks3-go-unit-tests> === RUN   TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle
niks3-go-unit-tests> === PAUSE TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle
niks3-go-unit-tests> === RUN   TestProxyWriteTimeout
niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout
niks3-go-unit-tests> === RUN   TestIsValidUploadKey
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody
niks3-go-unit-tests> === RUN   TestService_cleanupPendingClosuresHandler
niks3-go-unit-tests> === PAUSE TestService_cleanupPendingClosuresHandler
niks3-go-unit-tests> === RUN   TestService_createPendingClosureHandler
niks3-go-unit-tests> === PAUSE TestService_createPendingClosureHandler
niks3-go-unit-tests> === RUN   TestService_verifyS3Integrity
niks3-go-unit-tests> === PAUSE TestService_verifyS3Integrity
niks3-go-unit-tests> === RUN   TestCompleteMultipartUnregistered
niks3-go-unit-tests> === PAUSE TestCompleteMultipartUnregistered
niks3-go-unit-tests> === CONT  TestService_AuthMiddleware
niks3-go-unit-tests> === CONT  TestMultipartCleanup
niks3-go-unit-tests> === CONT  TestGCTaskStore_StartNew
niks3-go-unit-tests> === CONT  TestCompleteMultipartUnregistered
niks3-go-unit-tests> --- PASS: TestGCTaskStore_StartNew (0.00s)
niks3-go-unit-tests> === CONT  TestServerTLSConfig
niks3-go-unit-tests> === RUN   TestServerTLSConfig/no_client_CA
niks3-go-unit-tests> === PAUSE TestServerTLSConfig/no_client_CA
niks3-go-unit-tests> === RUN   TestServerTLSConfig/missing_CA_file
niks3-go-unit-tests> === PAUSE TestServerTLSConfig/missing_CA_file
niks3-go-unit-tests> === RUN   TestServerTLSConfig/not_a_PEM_file
niks3-go-unit-tests> === PAUSE TestServerTLSConfig/not_a_PEM_file
niks3-go-unit-tests> === CONT  TestService_verifyS3Integrity
niks3-go-unit-tests> === CONT  TestServerTLSConfig/no_client_CA
niks3-go-unit-tests> === CONT  TestService_NativeMTLS
niks3-go-unit-tests> === CONT  TestGCTaskStore_PhaseUpdates
niks3-go-unit-tests> --- PASS: TestGCTaskStore_PhaseUpdates (0.00s)
niks3-go-unit-tests> === CONT  TestGCTaskStore_CompletedAllowsNewTask
niks3-go-unit-tests> === CONT  TestNARDeduplicationMetadataUploadBug
niks3-go-unit-tests> === CONT  TestGenerateLandingPage
niks3-go-unit-tests> === CONT  TestService_healthCheckHandler
niks3-go-unit-tests> === CONT  TestGCTaskStore_Fail
niks3-go-unit-tests> === CONT  TestGCTaskStore_GetEmpty
niks3-go-unit-tests> === CONT  TestGCTaskStore_ConflictDifferentParams
niks3-go-unit-tests> === CONT  TestGCTaskStore_DeduplicateSameParams
niks3-go-unit-tests> === CONT  TestServerTLSConfig/not_a_PEM_file
niks3-go-unit-tests> --- PASS: TestGCTaskStore_CompletedAllowsNewTask (0.00s)
niks3-go-unit-tests> --- PASS: TestGCTaskStore_Fail (0.00s)
niks3-go-unit-tests> --- PASS: TestGCTaskStore_GetEmpty (0.00s)
niks3-go-unit-tests> --- PASS: TestGCTaskStore_ConflictDifferentParams (0.00s)
niks3-go-unit-tests> --- PASS: TestGCTaskStore_DeduplicateSameParams (0.00s)
niks3-go-unit-tests> === CONT  TestGCTaskStore_GetReturnsLatest
niks3-go-unit-tests> --- PASS: TestGCTaskStore_GetReturnsLatest (0.00s)
niks3-go-unit-tests> === CONT  TestServerTLSConfig/missing_CA_file
niks3-go-unit-tests> === CONT  TestClientWithDependencies
niks3-go-unit-tests> --- PASS: TestServerTLSConfig (0.00s)
niks3-go-unit-tests>     --- PASS: TestServerTLSConfig/no_client_CA (0.00s)
niks3-go-unit-tests>     --- PASS: TestServerTLSConfig/missing_CA_file (0.00s)
niks3-go-unit-tests>     --- PASS: TestServerTLSConfig/not_a_PEM_file (0.00s)
niks3-go-unit-tests> === CONT  TestGCBugBareHashReferences
niks3-go-unit-tests> --- PASS: TestGenerateLandingPage (0.00s)
niks3-go-unit-tests> === CONT  TestPinProtectsFromGC
niks3-go-unit-tests> 2026-06-08 09:35:29.212 UTC [44381] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.212 UTC [44381] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.231 UTC [44382] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.231 UTC [44382] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.234 UTC [44383] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.234 UTC [44383] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (17.9ms)
niks3-go-unit-tests> 2026-06-08 09:35:29.240 UTC [44385] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.240 UTC [44385] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.240 UTC [44384] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.240 UTC [44384] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.240 UTC [44386] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.240 UTC [44386] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.38ms)
niks3-go-unit-tests> 2026-06-08 09:35:29.242 UTC [44389] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.242 UTC [44389] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.242 UTC [44388] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.242 UTC [44388] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.243 UTC [44387] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.243 UTC [44387] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.243 UTC [44390] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.243 UTC [44390] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (3.65ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (2.1ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (10.06ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (14.54ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (11.76ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Created nix-cache-info in bucket bucket=bucket1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (9.84ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (7.42ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (5.86ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (7.89ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.26ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (979.96µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (8.54ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (625.96µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (848.63µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (9.85ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (954µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.22ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.3ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.15ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (1.77ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (1.96ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.28ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (11.92ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (1.43ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.4ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.41ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.6ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.99ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.47ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.2ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.54ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.32ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.96ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.35ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.63ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.08ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.28ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN mTLS auth: subject not in bound subjects subject="CN=reader"
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN mTLS auth: subject not in bound subjects subject="CN=writer"
niks3-go-unit-tests> --- PASS: TestService_NativeMTLS (0.62s)
niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_OIDC
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> --- PASS: TestService_healthCheckHandler (0.62s)
niks3-go-unit-tests> === CONT  TestClientCADerivations
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (2.4ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Created nix-cache-info in bucket bucket=bucket5
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO OIDC provider initialized name=test
niks3-go-unit-tests> 2026/06/08 09:35:29 ERROR Multipart upload not found error="no rows in result set" upload_id=does-not-exist object_key=nar/0000000000000000000000000000000000000000000000000000.nar.zst
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Created nix-cache-info in bucket bucket=bucket3
niks3-go-unit-tests> --- PASS: TestCompleteMultipartUnregistered (0.62s)
niks3-go-unit-tests> === CONT  TestCacheConfigHandler
niks3-go-unit-tests> === RUN   TestCacheConfigHandler/full_config,_no_issuer
niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/full_config,_no_issuer
niks3-go-unit-tests> === RUN   TestCacheConfigHandler/no_cache_url_configured
niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/no_cache_url_configured
niks3-go-unit-tests> === RUN   TestCacheConfigHandler/no_signing_keys
niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/no_signing_keys
niks3-go-unit-tests> === RUN   TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator
niks3-go-unit-tests> === PAUSE TestCacheConfigHandler/issuer_requested_but_no_OIDC_validator
niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_MTLSBoundSubjects
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN Authentication failed token_preview=wrongtoken token_length=10 reason="static API token mismatch"
niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware (0.63s)
niks3-go-unit-tests> === CONT  TestService_ReadAuthMiddleware
niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug
niks3-go-unit-tests>     metadata_upload_test.go:48: First store path: /nix/var/nix/builds/nix-43615-2689963028/TestNARDeduplicationMetadataUploadBug1277818258/001/store/awvdk0l76gz0dxvqn2x5va4mvyyqrxg5-file1.txt
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received cleanup request method=DELETE path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Aborted multipart uploads count=1
niks3-go-unit-tests> --- PASS: TestMultipartCleanup (0.74s)
niks3-go-unit-tests> === CONT  TestClientMultipleUploads
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> === NAME  TestPinProtectsFromGC
niks3-go-unit-tests>     client_integration_test.go:647: Pinned store path: /nix/var/nix/builds/nix-43615-2689963028/TestPinProtectsFromGC3234618604/001/store/n8ipgvxikxd6zrr4j56v18393hsim1jn-pinned-file.txt
niks3-go-unit-tests>     client_integration_test.go:648: Unpinned store path: /nix/var/nix/builds/nix-43615-2689963028/TestPinProtectsFromGC3234618604/001/store/vfd8aw1rzd0xwzmhsmbysy4i33ad2dbx-unpinned-file.txt
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/dadb44fdadb44fdadb44fdadb44f000000000000000000000000.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5Ljk1ZTFkMWI0LTYyMGItNDRlZS05M2Q3LWNhMmVkYjgwNzYxMngxNzgwOTExMzI5MjY5NjQ5MDAw parts=10
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026-06-08 09:35:29.437 UTC [44418] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.437 UTC [44418] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Object in database but missing from S3 key=dadb44fdadb44fdadb44fdadb44f0000.narinfo
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN Found objects in DB but missing from S3, will re-upload count=1
niks3-go-unit-tests> --- PASS: TestService_verifyS3Integrity (0.80s)
niks3-go-unit-tests> === CONT  TestService_AuthMiddleware_MTLSProxyHeader
niks3-go-unit-tests> 2026-06-08 09:35:29.440 UTC [44419] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.440 UTC [44419] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.440 UTC [44420] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.440 UTC [44420] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.443 UTC [44421] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.443 UTC [44421] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (18.5ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (16.13ms)
niks3-go-unit-tests> === NAME  TestClientWithDependencies
niks3-go-unit-tests>     client_integration_test.go:593: Built derivation: /nix/var/nix/builds/nix-43615-2689963028/TestClientWithDependencies3677146121/001/store/4dj2il27hb4370nz5pbdyzgs3zgk2lx8-test-script
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (25.25ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (9.11ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (9.89ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (2.34ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.58ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (3.34ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (27.7ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (2.26ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026-06-08 09:35:29.477 UTC [44428] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.477 UTC [44428] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.83ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.8ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.03ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (1.54ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (2.11ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/valid_OIDC_token
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/valid_OIDC_token
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/OIDC_token_with_wrong_org_rejected
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/malformed_token_rejected
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/malformed_token_rejected
niks3-go-unit-tests> === RUN   TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured
niks3-go-unit-tests> === PAUSE TestService_AuthMiddleware_OIDC/static_token_still_works_with_OIDC_configured
niks3-go-unit-tests> === CONT  TestReadProxyConditionalGet
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (2.14ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN mTLS auth: subject not in bound subjects subject="CN=untrusted,O=Other"
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN mTLS auth: bound subjects configured but subject DN unavailable
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN mTLS auth: subject not in bound subjects subject="CN=untrusted"
niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_MTLSBoundSubjects (0.21s)
niks3-go-unit-tests> === CONT  TestService_createPendingClosureHandler
niks3-go-unit-tests> --- PASS: TestGCBugBareHashReferences (0.84s)
niks3-go-unit-tests> === CONT  TestService_cleanupPendingClosuresHandler
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Created nix-cache-info in bucket bucket=bucket13
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN mTLS auth: subject not in bound subjects subject="CN=writer"
niks3-go-unit-tests> --- PASS: TestService_ReadAuthMiddleware (0.22s)
niks3-go-unit-tests> === CONT  TestUploadHandlersRejectOversizedBody
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (8.93ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.69ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.17ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026-06-08 09:35:29.510 UTC [44440] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.510 UTC [44440] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (2.84ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody/create_pending_closure
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/create_pending_closure
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody/complete_multipart
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Created nix-cache-info in bucket bucket=bucket15
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/complete_multipart
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectOversizedBody/request_more_parts
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectOversizedBody/request_more_parts
niks3-go-unit-tests> === CONT  TestUploadHandlersRejectInvalidKeys
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_nix-cache-info
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/create_pending_closure_rejects_path_traversal
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/complete_multipart_rejects_non-NAR_key
niks3-go-unit-tests> === RUN   TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key
niks3-go-unit-tests> === PAUSE TestUploadHandlersRejectInvalidKeys/request_more_parts_rejects_non-NAR_key
niks3-go-unit-tests> === CONT  TestIsValidUploadKey
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/narinfo
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/narinfo
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_zst
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_zst
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_xz
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_xz
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_plain
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_plain
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/listing
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/listing
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_home-manager_file
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_home-manager_file
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_plus_in_name
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_plus_in_name
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_question_mark
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_question_mark
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/build_log_equals
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/build_log_equals
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/realisation
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/realisation
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/realisation_plus_in_output
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/realisation_plus_in_output
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nix-cache-info
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nix-cache-info
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/index.html
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/index.html
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/narinfo_key,_nar_type
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/narinfo_key,_nar_type
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/nar_key,_narinfo_type
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/nar_key,_narinfo_type
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/listing_key,_narinfo_type
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/listing_key,_narinfo_type
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/traversal
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/traversal
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/traversal_nar
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/traversal_nar
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/absolute
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/absolute
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/empty_key
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/empty_key
niks3-go-unit-tests> === RUN   TestIsValidUploadKey/unknown_type
niks3-go-unit-tests> === PAUSE TestIsValidUploadKey/unknown_type
niks3-go-unit-tests> === CONT  TestProxyWriteTimeout
niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/narinfo
niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/narinfo
niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/1_GiB_nar
niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/1_GiB_nar
niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/10_GiB_nar
niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/10_GiB_nar
niks3-go-unit-tests> === RUN   TestProxyWriteTimeout/unknown_size
niks3-go-unit-tests> === PAUSE TestProxyWriteTimeout/unknown_size
niks3-go-unit-tests> === CONT  TestCompleteMultipartUploadHandler_RateLimitTriggersThrottle
niks3-go-unit-tests> === NAME  TestClientWithDependencies
niks3-go-unit-tests>     client_integration_test.go:595: Found 1 dependencies (including self)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (11.34ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (1.29ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (2.1ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.59ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> --- PASS: TestService_AuthMiddleware_MTLSProxyHeader (0.10s)
niks3-go-unit-tests> === CONT  TestService_Rustfstest
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading awvdk0l76gz0dxvqn2x5va4mvyyqrxg5-file1.txt (160B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> === NAME  TestClientMultipleUploads
niks3-go-unit-tests>     client_integration_test.go:338: Created store path 0: /nix/var/nix/builds/nix-43615-2689963028/TestClientMultipleUploads281710517/001/store/8vrdj3b64y26l3d3y941axyqv2i6vq65-test-file-0.txt
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LmYzOTE4Y2M4LThjNzEtNGQxZi1iMDhlLWU0MGM5NmNlNWU2NngxNzgwOTExMzI5NTUwMDMyMDAw parts=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=1 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 narinfos
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Upload complete. (185ms)
niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug
niks3-go-unit-tests>     metadata_upload_test.go:54: Retrieved narinfo from S3:
niks3-go-unit-tests>         StorePath: /nix/var/nix/builds/nix-43615-2689963028/TestNARDeduplicationMetadataUploadBug1277818258/001/store/awvdk0l76gz0dxvqn2x5va4mvyyqrxg5-file1.txt
niks3-go-unit-tests>         URL: nar/1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf.nar.zst
niks3-go-unit-tests>         Compression: zstd
niks3-go-unit-tests>         NarHash: sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf
niks3-go-unit-tests>         NarSize: 160
niks3-go-unit-tests>         References: 
niks3-go-unit-tests>         CA: fixed:r:sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf
niks3-go-unit-tests>     metadata_upload_test.go:55: Retrieved .ls file from S3 (compressed size: 77 bytes)
niks3-go-unit-tests>     metadata_upload_test.go:55: Decompressed .ls content (64 bytes):
niks3-go-unit-tests>         {"version":1,"root":{"type":"regular","size":44,"narOffset":96}}
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> === NAME  TestClientCADerivations
niks3-go-unit-tests>     client_ca_test.go:136: Built CA derivation: /nix/var/nix/builds/nix-43615-2689963028/TestClientCADerivations3356441522/001/store/xqlh6m35xhi7lnkg7sl5aaxfw82bhwva-ca-test
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading n8ipgvxikxd6zrr4j56v18393hsim1jn-pinned-file.txt (128B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 4dj2il27hb4370nz5pbdyzgs3zgk2lx8-test-script (136B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/0qmhsg42pqsz7x6hh02j8gznnac3yi3qpjhrqbwvz88i194jbb5s.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LjAwZGY4ZGM2LWYyNmYtNDZmOS1hNDNmLWZlOGQxMWFlYWFjYngxNzgwOTExMzI5NjI5OTA4MDAw parts=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign
niks3-go-unit-tests> === NAME  TestClientMultipleUploads
niks3-go-unit-tests>     client_integration_test.go:338: Created store path 1: /nix/var/nix/builds/nix-43615-2689963028/TestClientMultipleUploads281710517/001/store/sl2l7fvv8yrxxhi4ff90kkklhrfjqm45-test-file-1.txt
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=1 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 narinfos
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/1s7yghixzpinyqm7g59kyn3sav81pmnsdi5v63m6x4r2vacy907j.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LjgyMGY5NTU2LTQzMDMtNDc5Ni1iM2YwLTg1Njc4YWY2MjZiYngxNzgwOTExMzI5NjM1ODYwMDAw parts=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=1 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 narinfos
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Upload complete. (166ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Upload complete. (89ms)
niks3-go-unit-tests> === NAME  TestClientWithDependencies
niks3-go-unit-tests>     client_integration_test.go:597: Skipping nix copy test - isolated store (/nix/var/nix/builds/nix-43615-2689963028/TestClientWithDependencies3677146121/001/store) requires matching store prefix
niks3-go-unit-tests> --- PASS: TestClientWithDependencies (1.02s)
niks3-go-unit-tests> === CONT  TestReadProxyRangeRequest
niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug
niks3-go-unit-tests>     metadata_upload_test.go:64: Second store path (same content): /nix/var/nix/builds/nix-43615-2689963028/TestNARDeduplicationMetadataUploadBug1277818258/001/store/0l4ki5667pgb2i3vjxwfjbl3pzak7sjq-file2.txt
niks3-go-unit-tests> === NAME  TestClientCADerivations
niks3-go-unit-tests>     client_ca_test.go:139: Found 1 dependencies (including self)
niks3-go-unit-tests> === NAME  TestClientMultipleUploads
niks3-go-unit-tests>     client_integration_test.go:338: Created store path 2: /nix/var/nix/builds/nix-43615-2689963028/TestClientMultipleUploads281710517/001/store/3w81qfz6qhhwsz4j67maznh23bd7ln0d-test-file-2.txt
niks3-go-unit-tests> 2026-06-08 09:35:29.780 UTC [44488] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.780 UTC [44488] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.788 UTC [44491] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.788 UTC [44491] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026-06-08 09:35:29.789 UTC [44492] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.789 UTC [44492] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (12.54ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (12.64ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (678.67µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (773.75µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (1.06ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (1.2ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (16.13ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.61ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.79ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (905.21µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received cleanup request method=DELETE path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (1.64ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.51ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Aborted multipart uploads count=0
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> --- PASS: TestReadProxyConditionalGet (0.35s)
niks3-go-unit-tests> === CONT  TestReadProxyDisabled
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading vfd8aw1rzd0xwzmhsmbysy4i33ad2dbx-unpinned-file.txt (128B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received cleanup request method=DELETE path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Aborted multipart uploads count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026-06-08 09:35:29.839 UTC [44488] ERROR:  Closure does not exist: id=1
niks3-go-unit-tests> 2026-06-08 09:35:29.839 UTC [44488] CONTEXT:  PL/pgSQL function commit_pending_closure(bigint) line 16 at RAISE
niks3-go-unit-tests> 2026-06-08 09:35:29.839 UTC [44488] STATEMENT:  -- name: CommitPendingClosure :exec
niks3-go-unit-tests> 	SELECT commit_pending_closure($1::bigint)
niks3-go-unit-tests> 	
niks3-go-unit-tests> --- PASS: TestService_cleanupPendingClosuresHandler (0.36s)
niks3-go-unit-tests> === CONT  TestReadProxyRootRedirectsToIndexHTML
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/0gh0wdnr6gmk4r5sfzzh12isnl14rgmkrwy1ws41hpsrlndclg5h.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LjQ5YjgwMzY3LTYzNTktNDcwMy1hMjczLTliNjgyZTIzZDIyOXgxNzgwOTExMzI5ODMxOTE0MDAw parts=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=2 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 narinfos
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=2
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Upload complete. (129ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 0 paths to 127.0.0.1 (1 already cached)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=2 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 narinfos
niks3-go-unit-tests> 2026-06-08 09:35:29.858 UTC [44505] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.858 UTC [44505] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=2
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Upload complete. (127ms)
niks3-go-unit-tests> === NAME  TestNARDeduplicationMetadataUploadBug
niks3-go-unit-tests>     metadata_upload_test.go:76: Retrieved narinfo from S3:
niks3-go-unit-tests>         StorePath: /nix/var/nix/builds/nix-43615-2689963028/TestNARDeduplicationMetadataUploadBug1277818258/001/store/0l4ki5667pgb2i3vjxwfjbl3pzak7sjq-file2.txt
niks3-go-unit-tests>         URL: nar/1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf.nar.zst
niks3-go-unit-tests>         Compression: zstd
niks3-go-unit-tests>         NarHash: sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf
niks3-go-unit-tests>         NarSize: 160
niks3-go-unit-tests>         References: 
niks3-go-unit-tests>         CA: fixed:r:sha256:1byf36hhc5sn8lvwqfkjh3ybgn76slmx8naakslrypxs6mna71rf
niks3-go-unit-tests>     metadata_upload_test.go:77: Retrieved .ls file from S3 (compressed size: 62 bytes)
niks3-go-unit-tests>     metadata_upload_test.go:77: Decompressed .ls content (49 bytes):
niks3-go-unit-tests>         {"version":1,"root":{"type":"regular","size":44}}
niks3-go-unit-tests> --- PASS: TestNARDeduplicationMetadataUploadBug (1.22s)
niks3-go-unit-tests> === CONT  TestReadProxyNarinfo
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 paths to 127.0.0.1 (0 already cached)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading xqlh6m35xhi7lnkg7sl5aaxfw82bhwva-ca-test (144B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LjhiOWYwODQ2LWE4ZTMtNGY4MC1hZDBjLWExNDlkZTM4ODBiZngxNzgwOTExMzI5ODczOTM1MDAw parts=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=1 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 1 narinfos
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (19.23ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Upload complete. (150ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (973.67µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> === NAME  TestClientCADerivations
niks3-go-unit-tests>     client_ca_test.go:180: Narinfo contains CA field: StorePath: /nix/var/nix/builds/nix-43615-2689963028/TestClientCADerivations3356441522/001/store/xqlh6m35xhi7lnkg7sl5aaxfw82bhwva-ca-test
niks3-go-unit-tests>         URL: nar/04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n.nar.zst
niks3-go-unit-tests>         Compression: zstd
niks3-go-unit-tests>         NarHash: sha256:04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n
niks3-go-unit-tests>         NarSize: 144
niks3-go-unit-tests>         References: 
niks3-go-unit-tests>         Deriver: /nix/var/nix/builds/nix-43615-2689963028/TestClientCADerivations3356441522/001/store/k081wm40j6gyk9bjzl5284q07pxsl2ws-ca-test.drv
niks3-go-unit-tests>         CA: fixed:r:sha256:04jj7iiy79vhzp5kk3r2751n9x3xa44j98y5bk1ds4jp31kky74n
niks3-go-unit-tests>     client_ca_test.go:185: Checking for realisation files in S3...
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received create pin request method=POST path=/api/pins/myapp
niks3-go-unit-tests>     client_ca_test.go:207: No realisation files uploaded - this is expected for locally built CA derivations
niks3-go-unit-tests>     client_ca_test.go:208: Locally built CA derivations don't have DrvOutput IDs until they're substituted from a cache
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 3 paths to 127.0.0.1 (0 already cached)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading sl2l7fvv8yrxxhi4ff90kkklhrfjqm45-test-file-1.txt (160B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 3w81qfz6qhhwsz4j67maznh23bd7ln0d-test-file-2.txt (160B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 8vrdj3b64y26l3d3y941axyqv2i6vq65-test-file-0.txt (160B)
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Created/updated pin name=myapp store_path=/nix/var/nix/builds/nix-43615-2689963028/TestPinProtectsFromGC3234618604/001/store/n8ipgvxikxd6zrr4j56v18393hsim1jn-pinned-file.txt narinfo_key=n8ipgvxikxd6zrr4j56v18393hsim1jn.narinfo
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (8.81ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Starting cleanup of old closures method=DELETE path=/api/closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Garbage collection started
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.77ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/13p9pqi0ga6fx2apcwls9hjnv7nmf740ggpn5zvfzdsp5vz2bbg4.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LjJlNGI4ZjcyLTRmMTUtNDEzMC1hYjc3LTViYzRlODc4ODA4OHgxNzgwOTExMzI5ODkzMjY5MDAw parts=1
niks3-go-unit-tests> 2026-06-08 09:35:29.911 UTC [44512] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:29.911 UTC [44512] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/1823g6vx4q5zqvr73m7lkq1wpk40fin7bsc792di430yk7sg4lka.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LjEzYTE3YjNlLTYzNWQtNGJiYi04MTExLTRiOTMwYjk1MWQ5M3gxNzgwOTExMzI5ODk4MzgyMDAw parts=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/0ahq3izw3h0b0c08p3xdfclh758fwxnp85ccvflasb4vnfsv50ri.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LmI3MWU3N2QyLTFmNDItNDU2MC1hZDE1LTBkNDkyYjZkMjJlYXgxNzgwOTExMzI5ODk1Njc2MDAw parts=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/3/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=3 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=1 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received sign narinfos request method=POST path=/api/pending_closures/2/sign
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Signed narinfos id=2 count=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Uploading 3 narinfos
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Aborted multipart uploads count=0
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=2
niks3-go-unit-tests> 2026/06/08 09:35:29 WARN Force mode enabled - objects will be deleted immediately without grace period
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/3/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=3
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Upload complete. (157ms)
niks3-go-unit-tests> === NAME  TestClientMultipleUploads
niks3-go-unit-tests>     client_integration_test.go:349: Uploaded 3 paths in 211.458875ms
niks3-go-unit-tests> --- PASS: TestClientMultipleUploads (0.56s)
niks3-go-unit-tests> === CONT  TestReadProxyHead
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete multipart upload request method=POST path=/api/multipart/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed multipart upload object_key=nar/0000000000000000000000000000000000000000000000000000.nar.zst upload_id=YmExOWQwYzktMzRhNy00OWNjLWIxYzItNTRiZTJjNjg2ZWE5LmY2YWI2YTRjLWQ3MjUtNDBjMC1iNDk2LWFhZjI2YjNkOWY0OHgxNzgwOTExMzI5ODMxNTQyMDAw parts=10
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20241026095416_initial_model.sql (32.16ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251210153512_drop_unused_gin_index.sql (450.88µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   20251218171726_add_pins.sql (999.96µs)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Completed upload id=1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received get closure request method=GET path=/api/closures/00000000000000000000000000000000
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Received uploads request method=POST path=/api/pending_closures
niks3-go-unit-tests> 2026/06/08 09:35:29 OK   1_commit_pending_closure.sql (1.86ms)
niks3-go-unit-tests> 2026/06/08 09:35:29 goose: up to current file version: 1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Starting cleanup of old closures method=DELETE path=/api/closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Aborted multipart uploads count=0
niks3-go-unit-tests> --- PASS: TestService_Rustfstest (0.43s)
niks3-go-unit-tests> === CONT  TestReadProxyInvalidPath
niks3-go-unit-tests> 2026/06/08 09:35:29 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=0
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Vacuumed table table=pending_closures
niks3-go-unit-tests> === NAME  TestClientCADerivations
niks3-go-unit-tests>     client_ca_test.go:258: nix copy output: error: binary cache 's3://bucket13?endpoint=http://localhost:52136&region=eu-west-1' is for Nix stores with prefix '/nix/store', not '/nix/var/nix/builds/nix-43615-2689963028/TestClientCADerivations3356441522/001/store'
niks3-go-unit-tests>     client_ca_test.go:259: nix copy failed (might be expected with isolated stores): exit status 1
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Vacuumed table table=pending_objects
niks3-go-unit-tests> --- PASS: TestClientCADerivations (0.72s)
niks3-go-unit-tests> === CONT  TestReadProxy404
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Vacuumed table table=multipart_uploads
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Vacuumed table table=closures
niks3-go-unit-tests> 2026/06/08 09:35:29 INFO Vacuumed table table=objects
niks3-go-unit-tests> 2026/06/08 09:35:30 INFO Received get closure request method=GET path=/api/closures/00000000000000000000000000000000
niks3-go-unit-tests> --- PASS: TestService_createPendingClosureHandler (0.54s)
niks3-go-unit-tests> === CONT  TestReadProxyNarStreaming
niks3-go-unit-tests> 2026-06-08 09:35:30.080 UTC [44522] ERROR:  relation "goose_db_version" does not exist at character 36
niks3-go-unit-tests> 2026-06-08 09:35:30.080 UTC [44522] STATEMENT:  SELECT version_id, is_applied from goose_db_version ORDER BY id DESC
niks3-go-unit-tests> 2026/06/08 09:35:30 OK   20241026095416_initial_model.sql (10.35ms)
niks3-go-unit-tests> 2026/06/08 09:35:30 OK   20251210153512_drop_unused_gin_index.sql (465.79µs)
niks3-go-unit-tests> 2026/06/08 09:35:30 OK   20251218171726_add_pins.sql (737.33µs)
niks3-go-unit-tests> 2026/06/08 09:35:30 goose: successfully migrated database to version: 20251218171726
niks3-go-unit-tests> 2026/06/08 09:35:30 OK   1_commit_pending_closure.sql (860.08µs)
niks3-go-unit-tests> 2026/06/08 09:35:30 goose: up to current file version: 1
niks3-go-unit-tests> --- PASS: TestReadProxyRangeRequest (0.46s)
niks3-go-unit-tests> === CONT  TestReadProxyNarinfoAlreadyDecompressed
error: interrupted by the user