niks3-go-unit-tests
checks.aarch64-linux.go-unit-tests
· build #480
· raw
1tribuchet: building on eliza2Running client tests...3=== RUN TestPushPathsRefusesUntrustedClosure4--- PASS: TestPushPathsRefusesUntrustedClosure (0.03s)5=== RUN TestDoServerRequestAttachesToken6=== PAUSE TestDoServerRequestAttachesToken7=== RUN TestUploadBuildLog_FileBodyReplayedOnRetry8=== PAUSE TestUploadBuildLog_FileBodyReplayedOnRetry9=== RUN TestRegisterUploadedObjectReusesConnections10=== PAUSE TestRegisterUploadedObjectReusesConnections11=== RUN TestRunGarbageCollection_FinishedOnAnotherReplica12=== PAUSE TestRunGarbageCollection_FinishedOnAnotherReplica13=== RUN TestRunGarbageCollection_NotFoundAfterLocalRun14=== PAUSE TestRunGarbageCollection_NotFoundAfterLocalRun15=== RUN TestCaseHackSuffix16=== PAUSE TestCaseHackSuffix17=== RUN TestFilterOversizedClosures18=== PAUSE TestFilterOversizedClosures19=== RUN TestUploadMultipart_PartsInParallel20=== PAUSE TestUploadMultipart_PartsInParallel21=== RUN TestUploadMultipart_ReturnsAfterDroppedBody22=== PAUSE TestUploadMultipart_ReturnsAfterDroppedBody23=== RUN TestPartSizeForNAR24=== PAUSE TestPartSizeForNAR25=== RUN TestDumpPathCaseHackMatchesNix26--- PASS: TestDumpPathCaseHackMatchesNix (1.53s)27=== RUN TestDumpPathCaseHackCollision28--- PASS: TestDumpPathCaseHackCollision (0.00s)29=== RUN TestDumpPathMatchesNix30=== PAUSE TestDumpPathMatchesNix31=== RUN TestDumpPathSingleFile32=== PAUSE TestDumpPathSingleFile33=== RUN TestDumpPathWriterError34=== PAUSE TestDumpPathWriterError35=== RUN TestEncodeNixBase3236=== PAUSE TestEncodeNixBase3237=== RUN TestEncodeNixBase32WithRealHash38=== PAUSE TestEncodeNixBase32WithRealHash39=== RUN TestConvertHashToNix3240=== PAUSE TestConvertHashToNix3241=== RUN TestGetStorePathHash42=== PAUSE TestGetStorePathHash43=== RUN TestPathInfoHashCompatibility44=== PAUSE TestPathInfoHashCompatibility45=== RUN TestParsePathInfoJSON46=== PAUSE TestParsePathInfoJSON47=== RUN TestParsePathInfoJSONMultiplePaths48=== PAUSE TestParsePathInfoJSONMultiplePaths49=== RUN TestPathInfoCACompatibility50=== PAUSE TestPathInfoCACompatibility51=== RUN TestRateLimiterFeedback52=== PAUSE TestRateLimiterFeedback53=== RUN TestRateLimiterFeedback_400DoesNotCountAsSuccess54=== PAUSE TestRateLimiterFeedback_400DoesNotCountAsSuccess55=== RUN TestRegisterUploadedObject_BoundedAgainstSilentServer56=== PAUSE TestRegisterUploadedObject_BoundedAgainstSilentServer57=== RUN TestRegisterUploadedObject_OutlivesPush58=== PAUSE TestRegisterUploadedObject_OutlivesPush59=== RUN TestResolveStorePath60=== PAUSE TestResolveStorePath61=== RUN TestDoWithRetry_BodyReplayedViaGetBody62=== PAUSE TestDoWithRetry_BodyReplayedViaGetBody63=== RUN TestRetryTimeoutOutlastsMaxRetries64=== PAUSE TestRetryTimeoutOutlastsMaxRetries65=== RUN TestDoWithRetry_FinalResponseBodyReadable66=== PAUSE TestDoWithRetry_FinalResponseBodyReadable67=== RUN TestShellSplit68=== PAUSE TestShellSplit69=== RUN TestShellSplitErrors70=== PAUSE TestShellSplitErrors71=== RUN TestStreamPushReportsEveryPath72=== PAUSE TestStreamPushReportsEveryPath73=== RUN TestStreamPushBatchesUnderLoad74=== PAUSE TestStreamPushBatchesUnderLoad75=== RUN TestStreamPushIsolatesFailures76=== PAUSE TestStreamPushIsolatesFailures77=== RUN TestStreamPushGivesUpOnDeadServer78=== PAUSE TestStreamPushGivesUpOnDeadServer79=== RUN TestStreamPushRequestLine80=== PAUSE TestStreamPushRequestLine81=== RUN TestStreamPushReportsSignatures82=== PAUSE TestStreamPushReportsSignatures83=== RUN TestStreamPushReportsSkippedPaths84=== PAUSE TestStreamPushReportsSkippedPaths85=== RUN TestClientSignaturesByStorePath86=== PAUSE TestClientSignaturesByStorePath87=== RUN TestStreamPushStopsWhenCanceled88=== PAUSE TestStreamPushStopsWhenCanceled89=== RUN TestSetClientTLS90=== PAUSE TestSetClientTLS91=== RUN TestSetClientTLSDoesNotMutateDefaultTransport92=== PAUSE TestSetClientTLSDoesNotMutateDefaultTransport93=== RUN TestSetClientTLSErrors94=== PAUSE TestSetClientTLSErrors95=== RUN TestStaticToken96=== PAUSE TestStaticToken97=== RUN TestFileTokenReadsAndCaches98=== PAUSE TestFileTokenReadsAndCaches99=== RUN TestFileTokenMissing100=== PAUSE TestFileTokenMissing101=== RUN TestFileTokenEmpty102=== PAUSE TestFileTokenEmpty103=== RUN TestScriptTokenNoExpiryRerunsEveryCall104=== PAUSE TestScriptTokenNoExpiryRerunsEveryCall105=== RUN TestScriptTokenCachesUntilRefresh106=== PAUSE TestScriptTokenCachesUntilRefresh107=== RUN TestScriptTokenEmptyToken108=== PAUSE TestScriptTokenEmptyToken109=== RUN TestScriptTokenBadJSON110=== PAUSE TestScriptTokenBadJSON111=== RUN TestScriptTokenScriptFails112=== PAUSE TestScriptTokenScriptFails113=== RUN TestScriptTokenEmptyCommand114=== PAUSE TestScriptTokenEmptyCommand115=== RUN TestUntrustedPaths116=== PAUSE TestUntrustedPaths117=== RUN TestUntrustedPathsContentAddressed118=== PAUSE TestUntrustedPathsContentAddressed119=== RUN TestParsePathInfoUltimate120=== PAUSE TestParsePathInfoUltimate121=== CONT TestDoServerRequestAttachesToken122=== CONT TestScriptTokenEmptyToken123=== CONT TestFileTokenEmpty124=== CONT TestUntrustedPaths125=== RUN TestUntrustedPaths/server_without_policy_accepts_anything126=== PAUSE TestUntrustedPaths/server_without_policy_accepts_anything127=== RUN TestUntrustedPaths/built_locally128=== PAUSE TestUntrustedPaths/built_locally129=== RUN TestUntrustedPaths/signed_by_the_server_key130=== PAUSE TestUntrustedPaths/signed_by_the_server_key131=== RUN TestUntrustedPaths/signed_by_an_upstream_key132=== PAUSE TestUntrustedPaths/signed_by_an_upstream_key133=== RUN TestUntrustedPaths/unsigned_substitute134=== PAUSE TestUntrustedPaths/unsigned_substitute135=== RUN TestUntrustedPaths/signed_only_by_another_key136=== PAUSE TestUntrustedPaths/signed_only_by_another_key137=== RUN TestUntrustedPaths/another_key's_signature_under_the_server_key_name138=== PAUSE TestUntrustedPaths/another_key's_signature_under_the_server_key_name139=== RUN TestUntrustedPaths/server_signature_over_different_contents140=== PAUSE TestUntrustedPaths/server_signature_over_different_contents141=== CONT TestUntrustedPaths/server_without_policy_accepts_anything142--- PASS: TestFileTokenEmpty (0.00s)143=== CONT TestScriptTokenScriptFails144=== CONT TestScriptTokenBadJSON145=== CONT TestStreamPushReportsSkippedPaths146=== CONT TestScriptTokenEmptyCommand147--- PASS: TestScriptTokenEmptyCommand (0.00s)148=== CONT TestRateLimiterFeedback_400DoesNotCountAsSuccess149=== CONT TestUntrustedPaths/server_signature_over_different_contents150=== CONT TestUntrustedPaths/another_key's_signature_under_the_server_key_name151=== CONT TestUntrustedPaths/signed_only_by_another_key152=== CONT TestUntrustedPaths/unsigned_substitute153=== CONT TestUntrustedPaths/signed_by_an_upstream_key154=== CONT TestUntrustedPaths/signed_by_the_server_key155=== CONT TestUntrustedPaths/built_locally156=== CONT TestParsePathInfoUltimate157=== CONT TestRegisterUploadedObject_BoundedAgainstSilentServer158=== CONT TestFileTokenMissing159=== CONT TestFileTokenReadsAndCaches160=== CONT TestStaticToken161=== CONT TestSetClientTLSErrors162=== CONT TestSetClientTLSDoesNotMutateDefaultTransport163=== CONT TestSetClientTLS164=== CONT TestStreamPushStopsWhenCanceled165=== CONT TestClientSignaturesByStorePath166--- PASS: TestClientSignaturesByStorePath (0.00s)167=== CONT TestRateLimiterFeedback168=== RUN TestRateLimiterFeedback/429_enables_limiter169=== PAUSE TestRateLimiterFeedback/429_enables_limiter170=== RUN TestRateLimiterFeedback/503_enables_limiter171=== PAUSE TestRateLimiterFeedback/503_enables_limiter172=== RUN TestRateLimiterFeedback/200_does_not_enable_limiter173=== PAUSE TestRateLimiterFeedback/200_does_not_enable_limiter174=== RUN TestRateLimiterFeedback/400_does_not_enable_limiter175=== PAUSE TestRateLimiterFeedback/400_does_not_enable_limiter176=== CONT TestPathInfoCACompatibility177=== RUN TestPathInfoCACompatibility/null_ca_field178=== PAUSE TestPathInfoCACompatibility/null_ca_field179=== RUN TestPathInfoCACompatibility/old_string_format_-_text180=== PAUSE TestPathInfoCACompatibility/old_string_format_-_text181=== RUN TestPathInfoCACompatibility/old_string_format_-_fixed_recursive182=== PAUSE TestPathInfoCACompatibility/old_string_format_-_fixed_recursive183=== RUN TestPathInfoCACompatibility/new_structured_format_-_text184=== PAUSE TestPathInfoCACompatibility/new_structured_format_-_text185=== RUN TestPathInfoCACompatibility/new_structured_format_-_nar_method186=== PAUSE TestPathInfoCACompatibility/new_structured_format_-_nar_method187=== CONT TestParsePathInfoJSONMultiplePaths188=== RUN TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths189=== PAUSE TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths190=== RUN TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths191=== PAUSE TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths192=== CONT TestParsePathInfoJSON193=== RUN TestParsePathInfoJSON/Nix_format194=== PAUSE TestParsePathInfoJSON/Nix_format195=== RUN TestParsePathInfoJSON/Lix_format196=== PAUSE TestParsePathInfoJSON/Lix_format197=== RUN TestParsePathInfoJSON/empty_input198=== PAUSE TestParsePathInfoJSON/empty_input199=== RUN TestParsePathInfoJSON/whitespace_only200=== PAUSE TestParsePathInfoJSON/whitespace_only201=== RUN TestParsePathInfoJSON/invalid_JSON202=== PAUSE TestParsePathInfoJSON/invalid_JSON203=== CONT TestPathInfoHashCompatibility204=== RUN TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)205=== PAUSE TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)206=== RUN TestPathInfoHashCompatibility/old_string_format_with_colon207=== PAUSE TestPathInfoHashCompatibility/old_string_format_with_colon208=== RUN TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI209=== PAUSE TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI210=== RUN TestPathInfoHashCompatibility/new_structured_format_with_sha512211=== PAUSE TestPathInfoHashCompatibility/new_structured_format_with_sha512212=== CONT TestGetStorePathHash213=== RUN TestGetStorePathHash/valid_store_path214=== CONT TestConvertHashToNix32215=== RUN TestConvertHashToNix32/SRI_format_to_Nix32216--- PASS: TestStreamPushStopsWhenCanceled (0.00s)217--- PASS: TestFileTokenReadsAndCaches (0.00s)218=== PAUSE TestConvertHashToNix32/SRI_format_to_Nix32219=== RUN TestConvertHashToNix32/already_Nix32_format220=== CONT TestEncodeNixBase32221=== RUN TestEncodeNixBase32/test_string_hash222=== PAUSE TestEncodeNixBase32/test_string_hash223=== RUN TestEncodeNixBase32/empty_input224=== PAUSE TestEncodeNixBase32/empty_input225=== PAUSE TestGetStorePathHash/valid_store_path226=== CONT TestRunGarbageCollection_FinishedOnAnotherReplica227=== CONT TestRegisterUploadedObjectReusesConnections228=== CONT TestUploadBuildLog_FileBodyReplayedOnRetry229=== CONT TestScriptTokenCachesUntilRefresh2302026/11/10 21:17:33 WARN Rate limiter enabled after throttle name=server-test rate=5231=== RUN TestGetStorePathHash/basename_without_hyphen_should_error232=== PAUSE TestGetStorePathHash/basename_without_hyphen_should_error233=== RUN TestGetStorePathHash/hash_with_invalid_characters_should_error234=== PAUSE TestGetStorePathHash/hash_with_invalid_characters_should_error235=== RUN TestGetStorePathHash/hash_with_wrong_length_should_error236=== PAUSE TestGetStorePathHash/hash_with_wrong_length_should_error237=== PAUSE TestConvertHashToNix32/already_Nix32_format238=== RUN TestConvertHashToNix32/invalid_format239=== PAUSE TestConvertHashToNix32/invalid_format240=== CONT TestShellSplitErrors241=== CONT TestStreamPushRequestLine242=== CONT TestDumpPathWriterError243=== CONT TestDumpPathSingleFile244=== CONT TestDumpPathMatchesNix245--- PASS: TestParsePathInfoUltimate (0.00s)246--- PASS: TestStaticToken (0.00s)247--- PASS: TestScriptTokenScriptFails (4.14s)248=== CONT TestPartSizeForNAR2492026/11/10 21:17:37 ERROR Upload failed error=boom count=1250--- PASS: TestStreamPushReportsSkippedPaths (4.14s)251--- PASS: TestFileTokenMissing (0.00s)252=== RUN TestPartSizeForNAR/zero_stays_at_minimum2532026/11/10 21:17:39 WARN Request failed, retrying attempt=1 backoff=100ms error="Post \"http://127.0.0.1:32931/api/uploads/complete\": context deadline exceeded" url=http://127.0.0.1:32931/api/uploads/complete2542026/11/10 21:17:39 WARN Request failed, retrying attempt=1 backoff=100ms error="Post \"http://127.0.0.1:32931/api/uploads/complete\": context deadline exceeded" url=http://127.0.0.1:32931/api/uploads/complete255=== PAUSE TestPartSizeForNAR/zero_stays_at_minimum256=== CONT TestUploadMultipart_PartsInParallel257=== CONT TestFilterOversizedClosures258=== CONT TestCaseHackSuffix259=== CONT TestRunGarbageCollection_NotFoundAfterLocalRun260=== CONT TestEncodeNixBase32WithRealHash261=== CONT TestUploadMultipart_ReturnsAfterDroppedBody262=== CONT TestStreamPushReportsSignatures263--- PASS: TestShellSplitErrors (0.00s)264=== CONT TestStreamPushGivesUpOnDeadServer265=== CONT TestStreamPushIsolatesFailures266--- PASS: TestScriptTokenBadJSON (5.34s)267=== CONT TestStreamPushBatchesUnderLoad268--- PASS: TestUntrustedPaths (1.11s)269 --- PASS: TestUntrustedPaths/signed_only_by_another_key (0.00s)270 --- PASS: TestUntrustedPaths/built_locally (0.00s)271 --- PASS: TestUntrustedPaths/unsigned_substitute (0.00s)272 --- PASS: TestUntrustedPaths/another_key's_signature_under_the_server_key_name (0.00s)273 --- PASS: TestUntrustedPaths/signed_by_the_server_key (0.00s)274 --- PASS: TestUntrustedPaths/server_without_policy_accepts_anything (4.14s)275 --- PASS: TestUntrustedPaths/server_signature_over_different_contents (4.14s)276 --- PASS: TestUntrustedPaths/signed_by_an_upstream_key (0.00s)277--- PASS: TestEncodeNixBase32WithRealHash (0.00s)278--- PASS: TestScriptTokenEmptyToken (6.30s)2792026/11/10 21:17:39 ERROR Upload failed error="connection refused" count=202802026/11/10 21:17:39 ERROR Upload failed error=boom count=12812026/11/10 21:17:39 ERROR Server seems unavailable, giving up on batch untried=172822026/11/10 21:17:39 ERROR Upload failed error="bad path" count=3283--- PASS: TestStreamPushIsolatesFailures (0.00s)284=== CONT TestStreamPushReportsEveryPath285--- PASS: TestStreamPushReportsSignatures (0.00s)286=== CONT TestScriptTokenNoExpiryRerunsEveryCall287=== CONT TestShellSplit288=== CONT TestRetryTimeoutOutlastsMaxRetries2892026/11/10 21:17:39 WARN Failed to register uploaded object key=abc.narinfo error="sending request: context canceled during retry: context deadline exceeded"290=== CONT TestDoWithRetry_FinalResponseBodyReadable291=== CONT TestResolveStorePath292=== RUN TestPartSizeForNAR/small_stays_at_minimum293=== PAUSE TestPartSizeForNAR/small_stays_at_minimum294=== RUN TestPartSizeForNAR/80_GiB_fits_at_minimum295=== PAUSE TestPartSizeForNAR/80_GiB_fits_at_minimum296=== RUN TestPartSizeForNAR/115_GiB_needs_larger_parts297--- PASS: TestStreamPushGivesUpOnDeadServer (0.00s)298--- PASS: TestStreamPushReportsEveryPath (0.00s)299--- PASS: TestShellSplit (0.00s)300--- PASS: TestSetClientTLSDoesNotMutateDefaultTransport (2.16s)301=== PAUSE TestPartSizeForNAR/115_GiB_needs_larger_parts302=== RUN TestPartSizeForNAR/1_TiB303=== PAUSE TestPartSizeForNAR/1_TiB304=== RUN TestPartSizeForNAR/5_TiB_S3_max_object305=== PAUSE TestPartSizeForNAR/5_TiB_S3_max_object306=== RUN TestStreamPushBatchesUnderLoad/oneAtATime=false307=== RUN TestSetClientTLSErrors/missing_cert_file308=== PAUSE TestSetClientTLSErrors/missing_cert_file309=== RUN TestSetClientTLSErrors/missing_key_file310=== PAUSE TestSetClientTLSErrors/missing_key_file311=== RUN TestSetClientTLSErrors/missing_ca_file312=== PAUSE TestSetClientTLSErrors/missing_ca_file313=== RUN TestSetClientTLSErrors/invalid_ca_file314=== RUN TestFilterOversizedClosures/no_limit_keeps_everything315=== PAUSE TestFilterOversizedClosures/no_limit_keeps_everything316=== RUN TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped317=== PAUSE TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped318=== RUN TestFilterOversizedClosures/all_closures_skipped319=== PAUSE TestFilterOversizedClosures/all_closures_skipped320--- PASS: TestResolveStorePath (0.00s)321=== CONT TestRegisterUploadedObject_OutlivesPush3222026/11/10 21:17:39 WARN Failed to register uploaded object key=abc.narinfo error="sending request: context canceled during retry: context deadline exceeded"3232026/11/10 21:17:39 INFO Garbage collection started324=== PAUSE TestSetClientTLSErrors/invalid_ca_file3252026/11/10 21:17:39 WARN Request failed, retrying attempt=1 backoff=100ms error="Post \"http://127.0.0.1:32931/api/uploads/complete\": context deadline exceeded" url=http://127.0.0.1:32931/api/uploads/complete3262026/11/10 21:17:39 WARN Failed to register uploaded object key=abc.narinfo error="sending request: context canceled during retry: context deadline exceeded"327=== CONT TestDoWithRetry_BodyReplayedViaGetBody3282026/11/10 21:17:39 WARN Request returned retryable status, retrying attempt=1 backoff=1ms status=502 url=http://127.0.0.1:41953329=== CONT TestUntrustedPathsContentAddressed330--- PASS: TestRegisterUploadedObject_BoundedAgainstSilentServer (2.16s)331=== CONT TestRateLimiterFeedback/429_enables_limiter332=== RUN TestPartSizeForNAR/capped_at_5_GiB333=== PAUSE TestStreamPushBatchesUnderLoad/oneAtATime=false334=== CONT TestPathInfoCACompatibility/null_ca_field335--- PASS: TestDoServerRequestAttachesToken (6.31s)336=== PAUSE TestPartSizeForNAR/capped_at_5_GiB337=== CONT TestRateLimiterFeedback/400_does_not_enable_limiter338=== CONT TestRateLimiterFeedback/200_does_not_enable_limiter339--- PASS: TestUntrustedPathsContentAddressed (0.05s)340=== CONT TestRateLimiterFeedback/503_enables_limiter341--- PASS: TestScriptTokenNoExpiryRerunsEveryCall (0.06s)342=== CONT TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths3432026/11/10 21:17:40 INFO Garbage collection started344=== CONT TestPathInfoCACompatibility/new_structured_format_-_nar_method345=== CONT TestPathInfoCACompatibility/new_structured_format_-_text346=== CONT TestPathInfoCACompatibility/old_string_format_-_fixed_recursive3472026/11/10 21:17:40 WARN Rate limiter enabled after throttle name=server-test rate=5348=== CONT TestPathInfoCACompatibility/old_string_format_-_text3492026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:46693350--- PASS: TestPathInfoCACompatibility (0.00s)351 --- PASS: TestPathInfoCACompatibility/null_ca_field (0.00s)352 --- PASS: TestPathInfoCACompatibility/new_structured_format_-_nar_method (0.00s)353 --- PASS: TestPathInfoCACompatibility/new_structured_format_-_text (0.00s)354 --- PASS: TestPathInfoCACompatibility/old_string_format_-_fixed_recursive (0.00s)355 --- PASS: TestPathInfoCACompatibility/old_string_format_-_text (0.00s)356=== CONT TestParsePathInfoJSON/Nix_format3572026/11/10 21:17:40 INFO Garbage collection progress phase=running_on_another_replica failed_uploads_deleted=0 old_closures_deleted=0 objects_marked=0 objects_deleted=0 objects_failed=0358=== CONT TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths3592026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=2 backoff=1ms status=502 url=http://127.0.0.1:419533602026/11/10 21:17:40 WARN Rate limiter backed off name=server-test rate=5361--- PASS: TestParsePathInfoJSONMultiplePaths (0.00s)362 --- PASS: TestParsePathInfoJSONMultiplePaths/Nix_multiple_paths (0.00s)363 --- PASS: TestParsePathInfoJSONMultiplePaths/Lix_multiple_paths (0.00s)364=== CONT TestParsePathInfoJSON/whitespace_only365=== CONT TestParsePathInfoJSON/empty_input366=== CONT TestParsePathInfoJSON/invalid_JSON3672026/11/10 21:17:40 WARN Rate limiter enabled after throttle name=server-test rate=5368=== CONT TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI)369=== CONT TestPathInfoHashCompatibility/new_structured_format_with_sha5123702026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:43001371=== CONT TestParsePathInfoJSON/Lix_format372--- PASS: TestParsePathInfoJSON (0.00s)373 --- PASS: TestParsePathInfoJSON/Nix_format (0.00s)374 --- PASS: TestParsePathInfoJSON/whitespace_only (0.00s)375 --- PASS: TestParsePathInfoJSON/empty_input (0.00s)376 --- PASS: TestParsePathInfoJSON/invalid_JSON (0.00s)377 --- PASS: TestParsePathInfoJSON/Lix_format (0.00s)378=== CONT TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI379=== CONT TestEncodeNixBase32/empty_input380=== CONT TestGetStorePathHash/valid_store_path381=== CONT TestPathInfoHashCompatibility/old_string_format_with_colon3822026/11/10 21:17:40 WARN Rate limiter backed off name=server-test rate=5383=== CONT TestEncodeNixBase32/test_string_hash3842026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=2 backoff=0s status=503 url=http://127.0.0.1:43001385=== RUN TestSetClientTLS/rejects_connection_without_client_cert386=== PAUSE TestSetClientTLS/rejects_connection_without_client_cert387=== RUN TestSetClientTLS/succeeds_with_client_cert_and_CA388=== PAUSE TestSetClientTLS/succeeds_with_client_cert_and_CA389=== RUN TestSetClientTLS/preserves_debug_logging_transport390=== PAUSE TestSetClientTLS/preserves_debug_logging_transport391=== CONT TestGetStorePathHash/hash_with_invalid_characters_should_error392=== CONT TestConvertHashToNix32/invalid_format393=== CONT TestConvertHashToNix32/already_Nix32_format394=== CONT TestFilterOversizedClosures/no_limit_keeps_everything395=== CONT TestSetClientTLSErrors/missing_ca_file396=== CONT TestSetClientTLSErrors/invalid_ca_file397=== CONT TestSetClientTLSErrors/missing_key_file398=== CONT TestFilterOversizedClosures/all_closures_skipped3992026/11/10 21:17:40 WARN Garbage collection finished on another replica. Its statistics are not available here400=== CONT TestSetClientTLSErrors/missing_cert_file401=== CONT TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped4022026/11/10 21:17:40 WARN Skipping closure: path exceeds server max NAR size top_level_path=/nix/store/cccccccccccccccccccccccccccccccc-wrapper oversized_path=/nix/store/bbbbbbbbbbbbbbbbbbbbbbbbbbbbbbbb-vm-image nar_size=5000 max_nar_size=2000403=== CONT TestPartSizeForNAR/zero_stays_at_minimum4042026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=1 backoff=1ms status=502 url=http://127.0.0.1:41953405=== CONT TestPartSizeForNAR/5_TiB_S3_max_object4062026/11/10 21:17:40 WARN Skipping closure: path exceeds server max NAR size top_level_path=/nix/store/cccccccccccccccccccccccccccccccc-wrapper oversized_path=/nix/store/cccccccccccccccccccccccccccccccc-wrapper nar_size=100 max_nar_size=50407=== CONT TestPartSizeForNAR/1_TiB408=== CONT TestPartSizeForNAR/small_stays_at_minimum409--- PASS: TestPathInfoHashCompatibility (0.00s)410 --- PASS: TestPathInfoHashCompatibility/old_string_format_with_dash_(SRI) (0.00s)411 --- PASS: TestPathInfoHashCompatibility/new_structured_format_with_sha512 (0.00s)412 --- PASS: TestPathInfoHashCompatibility/new_structured_format_-_converts_to_SRI (0.00s)413 --- PASS: TestPathInfoHashCompatibility/old_string_format_with_colon (0.00s)414--- PASS: TestEncodeNixBase32 (0.00s)415 --- PASS: TestEncodeNixBase32/empty_input (0.00s)416 --- PASS: TestEncodeNixBase32/test_string_hash (0.00s)417=== CONT TestGetStorePathHash/basename_without_hyphen_should_error418=== CONT TestConvertHashToNix32/SRI_format_to_Nix32419=== CONT TestSetClientTLS/preserves_debug_logging_transport420--- PASS: TestScriptTokenCachesUntilRefresh (2.22s)4212026/11/10 21:17:39 WARN Rate limiter enabled after throttle name=server-test rate=5422=== CONT TestGetStorePathHash/hash_with_wrong_length_should_error4232026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:44691424=== CONT TestPartSizeForNAR/80_GiB_fits_at_minimum425=== CONT TestPartSizeForNAR/115_GiB_needs_larger_parts4262026/11/10 21:17:40 WARN Rate limiter enabled after throttle name=server-test rate=5427=== CONT TestSetClientTLS/rejects_connection_without_client_cert4282026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=429 url=http://127.0.0.1:377254292026/11/10 21:17:40 WARN Rate limiter backed off name=server-test rate=5430=== CONT TestPartSizeForNAR/capped_at_5_GiB431=== CONT TestSetClientTLS/succeeds_with_client_cert_and_CA4322026/11/10 21:17:40 WARN Rate limiter backed off name=server-test rate=5433--- PASS: TestRunGarbageCollection_NotFoundAfterLocalRun (0.06s)434--- PASS: TestConvertHashToNix32 (0.00s)435 --- PASS: TestConvertHashToNix32/invalid_format (0.00s)436 --- PASS: TestConvertHashToNix32/already_Nix32_format (0.00s)437 --- PASS: TestConvertHashToNix32/SRI_format_to_Nix32 (0.00s)438--- PASS: TestDoWithRetry_BodyReplayedViaGetBody (0.06s)439--- PASS: TestRunGarbageCollection_FinishedOnAnotherReplica (2.22s)440--- PASS: TestFilterOversizedClosures (0.00s)441 --- PASS: TestFilterOversizedClosures/no_limit_keeps_everything (0.00s)442 --- PASS: TestFilterOversizedClosures/closure_with_oversized_dependency_is_skipped (0.00s)443 --- PASS: TestFilterOversizedClosures/all_closures_skipped (0.00s)444=== RUN TestStreamPushBatchesUnderLoad/oneAtATime=true445=== PAUSE TestStreamPushBatchesUnderLoad/oneAtATime=true446=== CONT TestStreamPushBatchesUnderLoad/oneAtATime=false447--- PASS: TestUploadMultipart_ReturnsAfterDroppedBody (0.06s)448--- PASS: TestDoWithRetry_FinalResponseBodyReadable (0.06s)4492026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=2 backoff=1ms status=502 url=http://127.0.0.1:41953450--- PASS: TestGetStorePathHash (0.00s)451 --- PASS: TestGetStorePathHash/valid_store_path (0.00s)452 --- PASS: TestGetStorePathHash/hash_with_invalid_characters_should_error (0.00s)453 --- PASS: TestGetStorePathHash/basename_without_hyphen_should_error (0.00s)454 --- PASS: TestGetStorePathHash/hash_with_wrong_length_should_error (0.00s)455--- PASS: TestRateLimiterFeedback (0.00s)456 --- PASS: TestRateLimiterFeedback/200_does_not_enable_limiter (0.02s)457 --- PASS: TestRateLimiterFeedback/503_enables_limiter (0.00s)458 --- PASS: TestRateLimiterFeedback/400_does_not_enable_limiter (0.02s)459 --- PASS: TestRateLimiterFeedback/429_enables_limiter (0.06s)460--- PASS: TestRegisterUploadedObject_OutlivesPush (0.06s)461--- PASS: TestPartSizeForNAR (2.19s)462 --- PASS: TestPartSizeForNAR/zero_stays_at_minimum (0.00s)463 --- PASS: TestPartSizeForNAR/5_TiB_S3_max_object (0.00s)464 --- PASS: TestPartSizeForNAR/1_TiB (0.00s)465 --- PASS: TestPartSizeForNAR/small_stays_at_minimum (0.00s)466 --- PASS: TestPartSizeForNAR/80_GiB_fits_at_minimum (0.00s)467 --- PASS: TestPartSizeForNAR/115_GiB_needs_larger_parts (0.00s)468 --- PASS: TestPartSizeForNAR/capped_at_5_GiB (0.00s)469=== CONT TestStreamPushBatchesUnderLoad/oneAtATime=true4702026/11/10 21:17:40 WARN Rate limiter enabled after throttle name=s3-test rate=5471--- PASS: TestSetClientTLSErrors (2.16s)472 --- PASS: TestSetClientTLSErrors/missing_ca_file (0.00s)473 --- PASS: TestSetClientTLSErrors/missing_key_file (0.00s)474 --- PASS: TestSetClientTLSErrors/missing_cert_file (0.00s)475 --- PASS: TestSetClientTLSErrors/invalid_ca_file (0.00s)4762026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=1 backoff=0s status=503 url=http://127.0.0.1:45851477--- PASS: TestStreamPushBatchesUnderLoad (0.06s)478 --- PASS: TestStreamPushBatchesUnderLoad/oneAtATime=false (0.00s)479 --- PASS: TestStreamPushBatchesUnderLoad/oneAtATime=true (0.00s)480--- PASS: TestUploadBuildLog_FileBodyReplayedOnRetry (2.22s)4812026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=3 backoff=1ms status=502 url=http://127.0.0.1:419534822026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=4 backoff=1ms status=502 url=http://127.0.0.1:419534832026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=5 backoff=1ms status=502 url=http://127.0.0.1:419534842026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=6 backoff=1ms status=502 url=http://127.0.0.1:419534852026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=7 backoff=1ms status=502 url=http://127.0.0.1:419534862026/11/10 21:17:40 http: TLS handshake error from 127.0.0.1:33610: remote error: tls: bad certificate4872026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=8 backoff=1ms status=502 url=http://127.0.0.1:41953488--- PASS: TestSetClientTLS (2.22s)489 --- PASS: TestSetClientTLS/succeeds_with_client_cert_and_CA (0.01s)490 --- PASS: TestSetClientTLS/preserves_debug_logging_transport (0.01s)491 --- PASS: TestSetClientTLS/rejects_connection_without_client_cert (0.02s)4922026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=9 backoff=1ms status=502 url=http://127.0.0.1:419534932026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=10 backoff=1ms status=502 url=http://127.0.0.1:41953494--- PASS: TestDumpPathWriterError (2.24s)495--- PASS: TestRegisterUploadedObjectReusesConnections (2.24s)4962026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=11 backoff=1ms status=502 url=http://127.0.0.1:419534972026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=12 backoff=1ms status=502 url=http://127.0.0.1:419534982026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=13 backoff=1ms status=502 url=http://127.0.0.1:419534992026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=14 backoff=1ms status=502 url=http://127.0.0.1:41953500--- PASS: TestStreamPushRequestLine (2.24s)5012026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=15 backoff=1ms status=502 url=http://127.0.0.1:419535022026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=16 backoff=1ms status=502 url=http://127.0.0.1:419535032026/11/10 21:17:40 WARN Request returned retryable status, retrying attempt=17 backoff=1ms status=502 url=http://127.0.0.1:41953504--- PASS: TestRetryTimeoutOutlastsMaxRetries (0.09s)505--- PASS: TestUploadMultipart_PartsInParallel (0.67s)506--- PASS: TestRateLimiterFeedback_400DoesNotCountAsSuccess (7.15s)507--- PASS: TestDumpPathSingleFile (3.51s)508--- PASS: TestCaseHackSuffix (1.35s)509--- PASS: TestDumpPathMatchesNix (3.52s)510PASS511Running server tests...512The files belonging to this database system will be owned by user "nixbld".513This user must also own the server process.514515The database cluster will be initialized with locale "C".516The default database encoding has accordingly been set to "SQL_ASCII".517The default text search configuration will be set to "english".518519Data page checksums are enabled.520521creating directory /build/postgres592180642/data ... ok522creating subdirectories ... ok523selecting dynamic shared memory implementation ... posix524selecting default "max_connections" ... 100525selecting default "shared_buffers" ... 128MB526selecting default time zone ... UTC527creating configuration files ... ok528running bootstrap script ... ok529performing post-bootstrap initialization ... ok530syncing data to disk ... ok531532initdb: warning: enabling "trust" authentication for local connections533initdb: 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.534535Success. You can now start the database server using:536537 pg_ctl -D /build/postgres592180642/data -l logfile start538539/build/postgres592180642:5432 - no response540/build/postgres592180642:5432 - no response541/build/postgres592180642:5432 - no response542/build/postgres592180642:5432 - no response543/build/postgres592180642:5432 - no response544/build/postgres592180642:5432 - no response545/build/postgres592180642:5432 - no response546/build/postgres592180642:5432 - no response547/build/postgres592180642:5432 - no response548/build/postgres592180642:5432 - no response549/build/postgres592180642:5432 - no response550/build/postgres592180642:5432 - no response551/build/postgres592180642:5432 - no response552/build/postgres592180642:5432 - no response553/build/postgres592180642:5432 - no response554/build/postgres592180642:5432 - no response555/build/postgres592180642:5432 - no response556/build/postgres592180642:5432 - no response557/build/postgres592180642:5432 - no response558/build/postgres592180642:5432 - no response559/build/postgres592180642:5432 - no response560/build/postgres592180642:5432 - no response561/build/postgres592180642:5432 - no response562/build/postgres592180642:5432 - no response563/build/postgres592180642:5432 - no response564/build/postgres592180642:5432 - no response565/build/postgres592180642:5432 - no response566/build/postgres592180642:5432 - no response567/build/postgres592180642:5432 - no response568/build/postgres592180642:5432 - no response5692026-11-10 21:17:56.412 UTC [135] LOG: starting PostgreSQL 18.6 on aarch64-unknown-linux-gnu, compiled by clang version 21.1.8, 64-bit5702026-11-10 21:17:56.412 UTC [135] LOG: listening on Unix socket "/build/postgres592180642/.s.PGSQL.5432"5712026-11-10 21:17:56.419 UTC [135] LOG: received smart shutdown request5722026-11-10 21:17:56.421 UTC [171] LOG: database system was shut down at 2026-11-10 21:17:46 UTC5732026-11-10 21:17:56.427 UTC [169] LOG: shutting down5742026-11-10 21:17:56.427 UTC [169] LOG: checkpoint starting: shutdown immediate5752026-11-10 21:17:56.431 UTC [169] LOG: checkpoint complete: wrote 0 buffers (0.0%), wrote 3 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.004 s; sync files=2, longest=0.001 s, average=0.001 s; distance=0 kB, estimate=0 kB; lsn=0/1765D58, redo lsn=0/1765D585762026-11-10 21:17:56.453 UTC [135] LOG: database system is shut down5772026/11/10 21:17:56 ERROR failed to start postgres error="failed to wait for postgres: exit status 2"